builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1470660714.19 results: success (0) buildid: 20160808031752 builduid: c9d2f9c3ca074b0999bdc0a8216d97a6 revision: 1fa92a8698a9f605528701fb8cf33608e3e19650 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.188713) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.189239) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.189667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.213427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.213820) ========= 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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-08 05:51:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-08-08 05:51:54 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.374017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.374750) ========= 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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.020702 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:54.425644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:51:54.425988) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1fa92a8698a9f605528701fb8cf33608e3e19650 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 1fa92a8698a9f605528701fb8cf33608e3e19650 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-08 05:51:54,502 truncating revision to first 12 chars 2016-08-08 05:51:54,502 Setting DEBUG logging. 2016-08-08 05:51:54,502 attempt 1/10 2016-08-08 05:51:54,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1fa92a8698a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:51:56,161 unpacking tar archive at: autoland-1fa92a8698a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.936356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:51:56.384356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:56.384697) ========= script_repo_revision: 1fa92a8698a9f605528701fb8cf33608e3e19650 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:56.385111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:56.385377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:56.407519) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 05:51:56.407909) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:51:56 INFO - MultiFileLogger online at 20160808 05:51:56 in /builds/slave/test 05:51:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 05:51:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:56 INFO - {'append_to_log': False, 05:51:56 INFO - 'base_work_dir': '/builds/slave/test', 05:51:56 INFO - 'blob_upload_branch': 'Autoland', 05:51:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:56 INFO - 'branch': 'Autoland', 05:51:56 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:56 INFO - 'config_files': ('talos/mac_config.py',), 05:51:56 INFO - 'default_actions': ('clobber', 05:51:56 INFO - 'read-buildbot-config', 05:51:56 INFO - 'download-and-extract', 05:51:56 INFO - 'populate-webroot', 05:51:56 INFO - 'create-virtualenv', 05:51:56 INFO - 'install', 05:51:56 INFO - 'run-tests'), 05:51:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:56 INFO - 'download_minidump_stackwalk': True, 05:51:56 INFO - 'download_symbols': 'ondemand', 05:51:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:56 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:56 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:56 INFO - 'installer_path': 'installer.exe', 05:51:56 INFO - 'log_level': 'info', 05:51:56 INFO - 'log_name': 'talos', 05:51:56 INFO - 'log_to_console': True, 05:51:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:51:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:51:56 INFO - 'opt_config_files': (), 05:51:56 INFO - 'pip_index': False, 05:51:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:56 INFO - 'cmd': ('bash', 05:51:56 INFO - '-c', 05:51:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:56 INFO - 'enabled': True, 05:51:56 INFO - 'halt_on_failure': False, 05:51:56 INFO - 'name': 'check_screen_resolution'},), 05:51:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:56 INFO - 'cmd': ('bash', 05:51:56 INFO - '-c', 05:51:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:56 INFO - 'enabled': True, 05:51:56 INFO - 'halt_on_failure': False, 05:51:56 INFO - 'name': 'check_screen_resolution'},), 05:51:56 INFO - 'run_cmd_checks_enabled': True, 05:51:56 INFO - 'sps_profile': False, 05:51:56 INFO - 'sps_profile_interval': 0, 05:51:56 INFO - 'suite': 'dromaeojs', 05:51:56 INFO - 'system_bits': '32', 05:51:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:56 INFO - 'title': 't-yosemite-r7-0177', 05:51:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:56 INFO - 'use_talos_json': True, 05:51:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:56 INFO - 'work_dir': 'build'} 05:51:56 INFO - [mozharness: 2016-08-08 12:51:56.596410Z] Running clobber step. 05:51:56 INFO - Running pre-action listener: _resource_record_pre_action 05:51:56 INFO - Running main action method: clobber 05:51:56 INFO - rmtree: /builds/slave/test/build 05:51:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:57 INFO - Running post-action listener: _resource_record_post_action 05:51:57 INFO - [mozharness: 2016-08-08 12:51:57.493025Z] Finished clobber step (success) 05:51:57 INFO - [mozharness: 2016-08-08 12:51:57.493134Z] Running read-buildbot-config step. 05:51:57 INFO - Running pre-action listener: _resource_record_pre_action 05:51:57 INFO - Running main action method: read_buildbot_config 05:51:57 INFO - Using buildbot properties: 05:51:57 INFO - { 05:51:57 INFO - "project": "", 05:51:57 INFO - "product": "firefox", 05:51:57 INFO - "script_repo_revision": "production", 05:51:57 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 05:51:57 INFO - "repository": "", 05:51:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 05:51:57 INFO - "buildid": "20160808031752", 05:51:57 INFO - "pgo_build": "False", 05:51:57 INFO - "basedir": "/builds/slave/test", 05:51:57 INFO - "buildnumber": 87, 05:51:57 INFO - "slavename": "t-yosemite-r7-0177", 05:51:57 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:51:57 INFO - "platform": "yosemite_r7", 05:51:57 INFO - "scheduler": "tests-autoland-macosx64-talos", 05:51:57 INFO - "branch": "autoland", 05:51:57 INFO - "repo_path": "integration/autoland", 05:51:57 INFO - "revision": "1fa92a8698a9f605528701fb8cf33608e3e19650", 05:51:57 INFO - "stage_platform": "macosx64", 05:51:57 INFO - "builduid": "c9d2f9c3ca074b0999bdc0a8216d97a6", 05:51:57 INFO - "slavebuilddir": "test" 05:51:57 INFO - } 05:51:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:51:57 INFO - Running post-action listener: _resource_record_post_action 05:51:57 INFO - [mozharness: 2016-08-08 12:51:57.496037Z] Finished read-buildbot-config step (success) 05:51:57 INFO - [mozharness: 2016-08-08 12:51:57.496177Z] Running download-and-extract step. 05:51:57 INFO - Running pre-action listener: _resource_record_pre_action 05:51:57 INFO - Running main action method: download_and_extract 05:51:57 INFO - mkdir: /builds/slave/test/build/tests 05:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:57 INFO - trying https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:51:57 INFO - Downloading https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:51:58 INFO - Downloaded 1199 bytes. 05:51:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:51:58 INFO - Using the following test package requirements: 05:51:58 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:51:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:51:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:51:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'jsshell-mac.zip'], 05:51:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:51:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:51:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:51:58 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:51:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:51:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:58 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:51:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:58 INFO - trying https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:51:58 INFO - Downloading https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:51:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:51:59 INFO - Downloaded 16324264 bytes. 05:51:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:51:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:52:02 INFO - Return code: 0 05:52:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:02 INFO - trying https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:52:02 INFO - Downloading https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:52:03 INFO - Downloaded 16324264 bytes. 05:52:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:52:07 INFO - Return code: 0 05:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:07 INFO - trying https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:52:07 INFO - Downloading https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:52:08 INFO - Downloaded 14413723 bytes. 05:52:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:52:08 INFO - Return code: 0 05:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:08 INFO - trying https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:52:08 INFO - Downloading https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:52:11 INFO - Downloaded 111979244 bytes. 05:52:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:52:11 INFO - mkdir: /builds/slave/test/properties 05:52:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:11 INFO - Contents: 05:52:11 INFO - build_url:https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:52:12 INFO - Running post-action listener: _resource_record_post_action 05:52:12 INFO - Running post-action listener: set_extra_try_arguments 05:52:12 INFO - [mozharness: 2016-08-08 12:52:12.109614Z] Finished download-and-extract step (success) 05:52:12 INFO - [mozharness: 2016-08-08 12:52:12.109774Z] Running populate-webroot step. 05:52:12 INFO - Running pre-action listener: _resource_record_pre_action 05:52:12 INFO - Running main action method: populate_webroot 05:52:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:12 INFO - '--tppagecycles', 05:52:12 INFO - '7'], 05:52:12 INFO - 'tests': ['tsvgm']}}, 05:52:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['damp', 'tps']}, 05:52:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'tests': ['damp', 'tps']}, 05:52:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['dromaeo_dom']}, 05:52:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['basic_compositor_video']}, 05:52:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['a11yr', 05:52:12 INFO - 'ts_paint', 05:52:12 INFO - 'tpaint', 05:52:12 INFO - 'sessionrestore', 05:52:12 INFO - 'sessionrestore_no_auto_restore', 05:52:12 INFO - 'tabpaint']}, 05:52:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:12 INFO - 'ts_paint', 05:52:12 INFO - 'tpaint', 05:52:12 INFO - 'sessionrestore', 05:52:12 INFO - 'sessionrestore_no_auto_restore', 05:52:12 INFO - 'tabpaint']}, 05:52:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:12 INFO - 'ts_paint', 05:52:12 INFO - 'tpaint', 05:52:12 INFO - 'sessionrestore', 05:52:12 INFO - 'sessionrestore_no_auto_restore', 05:52:12 INFO - 'tabpaint']}, 05:52:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:12 INFO - 'ts_paint', 05:52:12 INFO - 'tpaint', 05:52:12 INFO - 'sessionrestore', 05:52:12 INFO - 'sessionrestore_no_auto_restore', 05:52:12 INFO - 'tabpaint']}, 05:52:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['a11yr', 05:52:12 INFO - 'ts_paint', 05:52:12 INFO - 'tpaint', 05:52:12 INFO - 'sessionrestore', 05:52:12 INFO - 'sessionrestore_no_auto_restore', 05:52:12 INFO - 'tabpaint']}, 05:52:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['a11yr', 05:52:12 INFO - 'ts_paint', 05:52:12 INFO - 'tpaint', 05:52:12 INFO - 'sessionrestore', 05:52:12 INFO - 'sessionrestore_no_auto_restore', 05:52:12 INFO - 'tabpaint']}, 05:52:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['tsvgx', 05:52:12 INFO - 'tsvgr_opacity', 05:52:12 INFO - 'tart', 05:52:12 INFO - 'tscrollx', 05:52:12 INFO - 'cart']}, 05:52:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:12 INFO - 'tsvgr_opacity', 05:52:12 INFO - 'tart', 05:52:12 INFO - 'tscrollx', 05:52:12 INFO - 'cart']}, 05:52:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'talos_options': ['--disable-e10s'], 05:52:12 INFO - 'tests': ['tp5o']}, 05:52:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'tests': ['tp5o']}, 05:52:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'talos_options': ['--disable-e10s', 05:52:12 INFO - '--xperf_path', 05:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:12 INFO - 'tests': ['tp5n']}, 05:52:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:12 INFO - 'talos_options': ['--xperf_path', 05:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:12 INFO - 'tests': ['tp5n']}}, 05:52:12 INFO - 'talos.zip': {'path': '', 05:52:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:12 INFO - Running post-action listener: _resource_record_post_action 05:52:12 INFO - [mozharness: 2016-08-08 12:52:12.128974Z] Finished populate-webroot step (success) 05:52:12 INFO - [mozharness: 2016-08-08 12:52:12.129092Z] Running create-virtualenv step. 05:52:12 INFO - Running pre-action listener: _resource_record_pre_action 05:52:12 INFO - Running main action method: create_virtualenv 05:52:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:52:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:12 INFO - Using real prefix '/tools/python27' 05:52:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:15 INFO - Installing pip.................done. 05:52:15 INFO - Return code: 0 05:52:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:15 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:15 INFO - 'HOME': '/Users/cltbld', 05:52:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:15 INFO - 'LOGNAME': 'cltbld', 05:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:15 INFO - 'MOZ_NO_REMOTE': '1', 05:52:15 INFO - 'NO_EM_RESTART': '1', 05:52:15 INFO - 'PAGER': '/bin/cat', 05:52:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:15 INFO - 'PWD': '/builds/slave/test', 05:52:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:15 INFO - 'SHELL': '/bin/bash', 05:52:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:15 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:15 INFO - 'USER': 'cltbld', 05:52:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:15 INFO - 'XPC_FLAGS': '0x0', 05:52:15 INFO - 'XPC_SERVICE_NAME': '0', 05:52:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:52:16 INFO - Cleaning up... 05:52:16 INFO - Return code: 0 05:52:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:16 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:16 INFO - 'HOME': '/Users/cltbld', 05:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:16 INFO - 'LOGNAME': 'cltbld', 05:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:16 INFO - 'MOZ_NO_REMOTE': '1', 05:52:16 INFO - 'NO_EM_RESTART': '1', 05:52:16 INFO - 'PAGER': '/bin/cat', 05:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:16 INFO - 'PWD': '/builds/slave/test', 05:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:16 INFO - 'SHELL': '/bin/bash', 05:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:16 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:16 INFO - 'USER': 'cltbld', 05:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:16 INFO - 'XPC_FLAGS': '0x0', 05:52:16 INFO - 'XPC_SERVICE_NAME': '0', 05:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:16 INFO - Downloading/unpacking psutil>=3.1.1 05:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:19 INFO - Installing collected packages: psutil 05:52:19 INFO - Running setup.py install for psutil 05:52:19 INFO - building 'psutil._psutil_osx' extension 05:52:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:52:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:52:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:52:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:52:20 INFO - building 'psutil._psutil_posix' extension 05:52:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:52:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:52:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:52:20 INFO - ^ 05:52:20 INFO - 1 warning generated. 05:52:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:20 INFO - Successfully installed psutil 05:52:20 INFO - Cleaning up... 05:52:20 INFO - Return code: 0 05:52:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:20 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:20 INFO - 'HOME': '/Users/cltbld', 05:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:20 INFO - 'LOGNAME': 'cltbld', 05:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:20 INFO - 'MOZ_NO_REMOTE': '1', 05:52:20 INFO - 'NO_EM_RESTART': '1', 05:52:20 INFO - 'PAGER': '/bin/cat', 05:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:20 INFO - 'PWD': '/builds/slave/test', 05:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:20 INFO - 'SHELL': '/bin/bash', 05:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:20 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:20 INFO - 'USER': 'cltbld', 05:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:20 INFO - 'XPC_FLAGS': '0x0', 05:52:20 INFO - 'XPC_SERVICE_NAME': '0', 05:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:23 INFO - Installing collected packages: mozsystemmonitor 05:52:23 INFO - Running setup.py install for mozsystemmonitor 05:52:23 INFO - Successfully installed mozsystemmonitor 05:52:23 INFO - Cleaning up... 05:52:23 INFO - Return code: 0 05:52:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:23 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:52:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:23 INFO - 'HOME': '/Users/cltbld', 05:52:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:23 INFO - 'LOGNAME': 'cltbld', 05:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:23 INFO - 'MOZ_NO_REMOTE': '1', 05:52:23 INFO - 'NO_EM_RESTART': '1', 05:52:23 INFO - 'PAGER': '/bin/cat', 05:52:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:23 INFO - 'PWD': '/builds/slave/test', 05:52:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:23 INFO - 'SHELL': '/bin/bash', 05:52:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:23 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:23 INFO - 'USER': 'cltbld', 05:52:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:23 INFO - 'XPC_FLAGS': '0x0', 05:52:23 INFO - 'XPC_SERVICE_NAME': '0', 05:52:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:26 INFO - warning: no files found matching '*.txt' 05:52:26 INFO - no previously-included directories found matching 'build' 05:52:26 INFO - no previously-included directories found matching 'dist' 05:52:26 INFO - no previously-included directories found matching '.git*' 05:52:26 INFO - Installing collected packages: jsonschema, functools32 05:52:26 INFO - Running setup.py install for functools32 05:52:26 INFO - warning: no files found matching '*.txt' 05:52:26 INFO - no previously-included directories found matching 'build' 05:52:26 INFO - no previously-included directories found matching 'dist' 05:52:26 INFO - no previously-included directories found matching '.git*' 05:52:26 INFO - Successfully installed jsonschema functools32 05:52:26 INFO - Cleaning up... 05:52:26 INFO - Return code: 0 05:52:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:26 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:27 INFO - 'HOME': '/Users/cltbld', 05:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:27 INFO - 'LOGNAME': 'cltbld', 05:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:27 INFO - 'MOZ_NO_REMOTE': '1', 05:52:27 INFO - 'NO_EM_RESTART': '1', 05:52:27 INFO - 'PAGER': '/bin/cat', 05:52:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:27 INFO - 'PWD': '/builds/slave/test', 05:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:27 INFO - 'SHELL': '/bin/bash', 05:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:27 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:27 INFO - 'USER': 'cltbld', 05:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:27 INFO - 'XPC_FLAGS': '0x0', 05:52:27 INFO - 'XPC_SERVICE_NAME': '0', 05:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:52:27 INFO - Cleaning up... 05:52:27 INFO - Return code: 0 05:52:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:27 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:27 INFO - 'HOME': '/Users/cltbld', 05:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:27 INFO - 'LOGNAME': 'cltbld', 05:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:27 INFO - 'MOZ_NO_REMOTE': '1', 05:52:27 INFO - 'NO_EM_RESTART': '1', 05:52:27 INFO - 'PAGER': '/bin/cat', 05:52:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:27 INFO - 'PWD': '/builds/slave/test', 05:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:27 INFO - 'SHELL': '/bin/bash', 05:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:27 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:27 INFO - 'USER': 'cltbld', 05:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:27 INFO - 'XPC_FLAGS': '0x0', 05:52:27 INFO - 'XPC_SERVICE_NAME': '0', 05:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:31 INFO - Downloading docopt-0.6.1.tar.gz 05:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:31 INFO - Running setup.py install for blobuploader 05:52:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:31 INFO - Running setup.py install for requests 05:52:31 INFO - Running setup.py install for docopt 05:52:31 INFO - Successfully installed blobuploader requests docopt 05:52:31 INFO - Cleaning up... 05:52:32 INFO - Return code: 0 05:52:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:32 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:32 INFO - 'HOME': '/Users/cltbld', 05:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:32 INFO - 'LOGNAME': 'cltbld', 05:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:32 INFO - 'MOZ_NO_REMOTE': '1', 05:52:32 INFO - 'NO_EM_RESTART': '1', 05:52:32 INFO - 'PAGER': '/bin/cat', 05:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:32 INFO - 'PWD': '/builds/slave/test', 05:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:32 INFO - 'SHELL': '/bin/bash', 05:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:32 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:32 INFO - 'USER': 'cltbld', 05:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:32 INFO - 'XPC_FLAGS': '0x0', 05:52:32 INFO - 'XPC_SERVICE_NAME': '0', 05:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-rWHcGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-o9ZsGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-w9pvaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-UpKJiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-4alkO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Tcyq3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:32 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-GS_oj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-gJpVGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8_oPUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-AYhzCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-hcm_F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-A7nMtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-2Yw1GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-fBIaoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-DWdqa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-LoSQQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-DoUtAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:34 INFO - Running setup.py install for manifestparser 05:52:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:34 INFO - Running setup.py install for mozcrash 05:52:34 INFO - Running setup.py install for mozdebug 05:52:34 INFO - Running setup.py install for mozdevice 05:52:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:34 INFO - Running setup.py install for mozfile 05:52:34 INFO - Running setup.py install for mozhttpd 05:52:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:34 INFO - Running setup.py install for mozinfo 05:52:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:35 INFO - Running setup.py install for mozInstall 05:52:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:35 INFO - Running setup.py install for mozleak 05:52:35 INFO - Running setup.py install for mozlog 05:52:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:35 INFO - Running setup.py install for moznetwork 05:52:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:35 INFO - Running setup.py install for mozprocess 05:52:35 INFO - Running setup.py install for mozprofile 05:52:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:36 INFO - Running setup.py install for mozrunner 05:52:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:36 INFO - Running setup.py install for mozscreenshot 05:52:36 INFO - Running setup.py install for moztest 05:52:36 INFO - Running setup.py install for mozversion 05:52:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:36 INFO - Cleaning up... 05:52:36 INFO - Return code: 0 05:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:36 INFO - 'HOME': '/Users/cltbld', 05:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PAGER': '/bin/cat', 05:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test', 05:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:36 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - 'XPC_FLAGS': '0x0', 05:52:36 INFO - 'XPC_SERVICE_NAME': '0', 05:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:36 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-BF02oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-FfdibA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-FNWfwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-u09jrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-N3coYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-suFtxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-oSIKo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Y6Cx09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-t4oaTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-D7ucww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8ZQmbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-SiYFIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-VF5uEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-GkUAqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-q8xQXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-oEXcTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-EbBP82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:41 INFO - Downloading blessings-1.6.tar.gz 05:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:41 INFO - Installing collected packages: blessings 05:52:41 INFO - Running setup.py install for blessings 05:52:41 INFO - Successfully installed blessings 05:52:41 INFO - Cleaning up... 05:52:41 INFO - Return code: 0 05:52:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:41 INFO - Reading from file tmpfile_stdout 05:52:41 INFO - Current package versions: 05:52:41 INFO - blessings == 1.6 05:52:41 INFO - blobuploader == 1.2.4 05:52:41 INFO - docopt == 0.6.1 05:52:41 INFO - functools32 == 3.2.3-2 05:52:41 INFO - jsonschema == 2.5.1 05:52:41 INFO - manifestparser == 1.1 05:52:41 INFO - mozInstall == 1.12 05:52:41 INFO - mozcrash == 0.17 05:52:41 INFO - mozdebug == 0.1 05:52:41 INFO - mozdevice == 0.48 05:52:41 INFO - mozfile == 1.2 05:52:41 INFO - mozhttpd == 0.7 05:52:41 INFO - mozinfo == 0.9 05:52:41 INFO - mozleak == 0.1 05:52:41 INFO - mozlog == 3.3 05:52:41 INFO - moznetwork == 0.27 05:52:41 INFO - mozprocess == 0.23 05:52:41 INFO - mozprofile == 0.28 05:52:41 INFO - mozrunner == 6.12 05:52:41 INFO - mozscreenshot == 0.1 05:52:41 INFO - mozsystemmonitor == 0.3 05:52:41 INFO - moztest == 0.7 05:52:41 INFO - mozversion == 1.4 05:52:41 INFO - psutil == 3.1.1 05:52:41 INFO - requests == 1.2.3 05:52:41 INFO - wsgiref == 0.1.2 05:52:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:41 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 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:41 INFO - 'HOME': '/Users/cltbld', 05:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:41 INFO - 'LOGNAME': 'cltbld', 05:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:41 INFO - 'MOZ_NO_REMOTE': '1', 05:52:41 INFO - 'NO_EM_RESTART': '1', 05:52:41 INFO - 'PAGER': '/bin/cat', 05:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:41 INFO - 'PWD': '/builds/slave/test', 05:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:41 INFO - 'SHELL': '/bin/bash', 05:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:41 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:41 INFO - 'USER': 'cltbld', 05:52:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:41 INFO - 'XPC_FLAGS': '0x0', 05:52:41 INFO - 'XPC_SERVICE_NAME': '0', 05:52:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:52:41 INFO - Cleaning up... 05:52:42 INFO - Return code: 0 05:52:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82558460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, '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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:42 INFO - 'HOME': '/Users/cltbld', 05:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:42 INFO - 'LOGNAME': 'cltbld', 05:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:42 INFO - 'MOZ_NO_REMOTE': '1', 05:52:42 INFO - 'NO_EM_RESTART': '1', 05:52:42 INFO - 'PAGER': '/bin/cat', 05:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:42 INFO - 'PWD': '/builds/slave/test', 05:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:42 INFO - 'SHELL': '/bin/bash', 05:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:52:42 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:42 INFO - 'USER': 'cltbld', 05:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:42 INFO - 'XPC_FLAGS': '0x0', 05:52:42 INFO - 'XPC_SERVICE_NAME': '0', 05:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:42 INFO - Cleaning up... 05:52:42 INFO - Return code: 0 05:52:42 INFO - Running post-action listener: _resource_record_post_action 05:52:42 INFO - Running post-action listener: _start_resource_monitoring 05:52:42 INFO - Starting resource monitoring. 05:52:42 INFO - [mozharness: 2016-08-08 12:52:42.298365Z] Finished create-virtualenv step (success) 05:52:42 INFO - [mozharness: 2016-08-08 12:52:42.299334Z] Running install step. 05:52:42 INFO - Running pre-action listener: _resource_record_pre_action 05:52:42 INFO - Running main action method: install 05:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:42 INFO - Reading from file tmpfile_stdout 05:52:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:42 INFO - Reading from file tmpfile_stdout 05:52:42 INFO - Output received: 05:52:42 INFO - Usage: mozinstall [options] installer 05:52:42 INFO - Options: 05:52:42 INFO - -h, --help show this help message and exit 05:52:42 INFO - -d DEST, --destination=DEST 05:52:42 INFO - Directory to install application into. [default: 05:52:42 INFO - "/builds/slave/test"] 05:52:42 INFO - --app=APP Application being installed. [default: firefox] 05:52:42 INFO - mkdir: /builds/slave/test/build/application 05:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:53:17 INFO - Reading from file tmpfile_stdout 05:53:17 INFO - Output received: 05:53:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:53:17 INFO - Running post-action listener: _resource_record_post_action 05:53:17 INFO - [mozharness: 2016-08-08 12:53:17.241519Z] Finished install step (success) 05:53:17 INFO - [mozharness: 2016-08-08 12:53:17.241655Z] Running run-tests step. 05:53:17 INFO - Running pre-action listener: _resource_record_pre_action 05:53:17 INFO - Running main action method: run_tests 05:53:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:17 INFO - 2016-08-08 05:53:17.256 screenresolution[1934:13376] starting screenresolution argv=screenresolution get 05:53:17 INFO - 2016-08-08 05:53:17.259 screenresolution[1934:13376] Display 0: 1600x1200x32@60 05:53:17 INFO - 2016-08-08 05:53:17.264 screenresolution[1935:13379] starting screenresolution argv=screenresolution list 05:53:17 INFO - Available Modes on Display 0 05:53:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:17 INFO - Intel Iris: 05:53:17 INFO - Chipset Model: Intel Iris 05:53:17 INFO - Type: GPU 05:53:17 INFO - Bus: Built-In 05:53:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:17 INFO - Vendor: Intel (0x8086) 05:53:17 INFO - Device ID: 0x0a2e 05:53:17 INFO - Revision ID: 0x0009 05:53:17 INFO - Displays: 05:53:17 INFO - Display: 05:53:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:17 INFO - Display Serial Number: 1600x1200 60 05:53:17 INFO - Main Display: Yes 05:53:17 INFO - Mirror: Off 05:53:17 INFO - Online: Yes 05:53:17 INFO - Rotation: Supported 05:53:17 INFO - Return code: 0 05:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:17 INFO - Python 2.7.3 05:53:17 INFO - Return code: 0 05:53:17 INFO - grabbing minidump binary from tooltool 05:53: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')]} 05:53:17 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 0x10f65ad30>, '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 0x10f3bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f652b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:53:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:53:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:53:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:17 INFO - Return code: 0 05:53:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:53:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:53:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 05:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --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 05:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXQe7bkLbS/Render', 05:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:17 INFO - 'HOME': '/Users/cltbld', 05:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:17 INFO - 'LOGNAME': 'cltbld', 05:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:17 INFO - 'MOZ_NO_REMOTE': '1', 05:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:17 INFO - 'NO_EM_RESTART': '1', 05:53:17 INFO - 'PAGER': '/bin/cat', 05:53:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:17 INFO - 'PWD': '/builds/slave/test', 05:53:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:17 INFO - 'SHELL': '/bin/bash', 05:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DiuGXj4Bbh/Listeners', 05:53:17 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 05:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:17 INFO - 'USER': 'cltbld', 05:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:17 INFO - 'XPC_FLAGS': '0x0', 05:53:17 INFO - 'XPC_SERVICE_NAME': '0', 05:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 05:53:17 INFO - mozversion application_buildid: 20160808031752 05:53:17 INFO - mozversion application_changeset: 1fa92a8698a9f605528701fb8cf33608e3e19650 05:53:17 INFO - mozversion application_display_name: Nightly 05:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:17 INFO - mozversion application_name: Firefox 05:53:17 INFO - mozversion application_remotingname: firefox 05:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 05:53:17 INFO - mozversion application_vendor: Mozilla 05:53:17 INFO - mozversion application_version: 51.0a1 05:53:17 INFO - mozversion platform_buildid: 20160808031752 05:53:17 INFO - mozversion platform_changeset: 1fa92a8698a9f605528701fb8cf33608e3e19650 05:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 05:53:17 INFO - mozversion platform_version: 51.0a1 05:53:17 INFO - using testdate: 1470660797 05:53:17 INFO - actual date: 1470660797 05:53:17 INFO - starting webserver on 'localhost:49391' 05:53:17 INFO - SUITE-START | Running 2 tests 05:53:17 INFO - TEST-START | dromaeo_css 05:53:17 INFO - operating with platform_type : mac_ 05:53:17 INFO - Initialising browser for dromaeo_css test... 05:53:17 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp86DPKb/profile http://localhost:49391/getInfo.html) 05:53:20 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 05:53:20 INFO - PROCESS | 1945 | colorDepth:24 05:53:20 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 05:53:20 INFO - PROCESS | 1945 | __metrics 05:53:20 INFO - PROCESS | 1945 | 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" 05:53:20 INFO - PROCESS | 1945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:20 INFO - TEST-INFO | 1945: exit 0 05:53:20 INFO - Browser initialized. 05:53:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:20 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp86DPKb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:32 INFO - PROCESS | 1947 | RSS: Main: 244588544 05:53:32 INFO - PROCESS | 1947 | 05:54:24 INFO - PROCESS | 1947 | 1470660864736 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:56:37 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49391/tests/dromaeo/cssquery-ext.html) 05:56:38 INFO - PROCESS | 1947 | RSS: Main: 364904448 05:56:38 INFO - PROCESS | 1947 | 05:59:41 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-ext.html (next: http://localhost:49391/tests/dromaeo/cssquery-jquery.html) 05:59:41 INFO - PROCESS | 1947 | RSS: Main: 393551872 05:59:41 INFO - PROCESS | 1947 | 06:02:44 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49391/tests/dromaeo/cssquery-mootools.html) 06:02:44 INFO - PROCESS | 1947 | RSS: Main: 354541568 06:02:44 INFO - PROCESS | 1947 | 06:05:47 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49391/tests/dromaeo/cssquery-prototype.html) 06:05:47 INFO - PROCESS | 1947 | RSS: Main: 359731200 06:05:47 INFO - PROCESS | 1947 | 06:08:51 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49391/tests/dromaeo/cssquery-yui.html) 06:08:51 INFO - PROCESS | 1947 | RSS: Main: 346587136 06:08:51 INFO - PROCESS | 1947 | 06:11:54 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-yui.html (next: http://localhost:49391/tests/dromaeo/cssquery-dojo.html) 06:11:55 INFO - PROCESS | 1947 | RSS: Main: 500330496 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | __start_tp_report 06:11:55 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 06:11:55 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 06:11:55 INFO - PROCESS | 1947 | |i|pagename|runs| 06:11:55 INFO - PROCESS | 1947 | |0;dojo.html;3295.5715756951595;3313.122022663994;3325.4679251319785;3343.465045592706;3353.228757385801;5521.337439507255;5636.070048442008;5675;5684.204211410406;5691.658500489968;5677.517411020068;5719.942800571993;5724.542036637069;5738.713064346787;5739.913901291484;5164.9741751291285;5189.766460509267;5217.947820521784;5228.764705588258;5291.920621190685;5232.110541207985;5245.8950820983555;5247.527722504974;5250.606204534656;5267.394249661281;4165.437665915093;5158.458361872005;5164.767585458663;5183.403908550508;5245.501677340647;5239.633225674185;5262.789488420459;5272.367315922113;5273.9736301318635;5332.9733351333;4055.7566546007333;5074.797008119671;5107.412647545506;5173.948260517422;5175.171972484384;5610.551155907518;5628.352739434977;5653.943460565383;5655.688937108457;5700.144978253295;6268.561200715952;6277.403646653561;6303.306636270053;6303.684815759239;6304;4539.727616342997;6105.429421494191;6144.771045790815;6217.813465596039;6260.561760676755;5783.161441590946;5795.159701843209;5803.303603567514;5806.187133801272;5823.854403639943;6231.501479881598;6239.001759718423;6239.376062393724;6250.15622890913;6267.310595834455;5969.820905372846;6109.434037704175;6117.296510901214;6170.074488826712;6177.938220617736;6245.219347581552;6263.373662633791;6269;6286.434220920048;6294.244690637152;6213.1922850029205;6254.15568898202;6260.373962603794;6270.498360131179;6281.214848143982;6119.908201376983;6143.542582966849;6145.095020543646;6154.599951003171;6214.751409943642;4893.779779909913;4939.87650308738;4940.8764780880765;4953.23224900141;4981.402231732143;4426.955730442719;4476.776161191992;4509.864704058883;4512.458504979358;4513.593776560059;5682.602217844794;5745.396733343023;5765.538756899438;5766.625169364062;5787.305523337226;5487.75305111271;5879.970600147058;6249.312575616678;6258.468030217483;6282.623042617458;5525.944740552623;5578.832635020955;5710.5717071219;5722.54219662426;5723.59934804568;5329.760160792774;5411.648242864201;5414.35027796667;5423.864403389947;5424.864378390572;6247.406496382836;6316.30520642729;6326.177596912372;6401.455876250385;6410.61536307823;6283.96858015707;6292.1505596743855;6296.33888441707;6306.873862522632;6323;6380.840478988062;6395.104685343963;6402.583832050902;6403.455706265019;6412.61524308543;6041.848953776015;6093.75624974996;6107.603005804608;6113.506711826627;6143.723532440961;5075.264086707481;6146.723397447215;6209.96895015522;6273;6284.811455656338;6131.188896256383;6142.04798256271;6153.6000159991245;6167.229096362955;6169.784057557964;6099.167614827221;6132.110843927695;6139.26328840542;6142.201513803177;6156.846078848064;5790.044642633919;5811.506021988178;5879.470847623735;5916.083007133901;6027.065804800263;6132.753252973555;6135.662538560422;6142.464383904024;6148.569600127948;6169.722362493609;5967.1049342597225;6010.33886272501;6026.909596356146;6036.094585812163;6048.274207095177 06:11:55 INFO - PROCESS | 1947 | |1;ext.html;492.2296605811904;510.98722531936704;523.3301374240968;536.7772374464597;556.0380541662925;30589.54115688264;41060.589394106086;42178.57821421789;42332;44344.22623095072;43822.78088609553;44150.55849441505;44197.779011104976;44227.33658995118;44267.77866110665;9719.805603887919;9947.1544918682;9949.353292035994;9954.65158719445;9959.203263738884;9766.365186262905;9875.407475551454;9885.90114098857;9888.11007009369;9891.455969921652;9850.704478865646;9915.25635577331;9923.603055877757;9943.701688949342;9944.105030547249;9832.31173817833;9882.160016398542;9885.01149885013;9902.702918912444;9902.851457228111;9696.563654635558;9785.559649815705;9787.531870219453;9790.608375664964;9829.655962041294;41441.58558414438;41804.58195418037;41817.37273940894;41822.74531764021;41854.79072604648;3447.3277710846396;3980.980095099506;4070.9619047143087;4164.312888373445;4348.804303806336;31767.682323176705;32371.514427283608;33143.6685633143;33324.6667533324;33514.32971340584;3228.4350238708134;3311.569495965509;3322.18606441421;3379;3415.1462134466383;518738.4063079698;523245;525225;526542;526642.7335726632;63054.68472657607;63542.046869296995;63549;63617.681911590145;63733.36266637367;66441;66565.6671716648;66572;66625.66748665097;66648.6670266592;16681.332746690237;16950.23723932426;16956.576085597957;16964.74552881708;16976.660466790843;12991.480340786451;13072.477100916047;13073.803892941614;13074.477020919247;13082;13251.337433128305;17725.645487090187;17841.46475605734;17866.28534858617;17930.820691793175;6040.486558642477;6042.456178943916;6047.183630209865;6119.4798442132915;6162.630242185483;918.4810582021137;946.6024269806697;976.3409698453515;1064.095518809006;1085.5983286184005;30986;31056;31249.8437507811;31509.8424507876;31657.208569785478;965.2712202287228;1066.6160182334354;1103.9282446640943;1135.1713249328036;1152.4180288954192;12736.745265094647;15712.450064247696;15981.520554383387;16122.516324510283;16491.91754041222;655239;656086;656330;656463;660215;58840;59133;59661.40338596558;59752;59824;1364.9590512284647;1389.8123753293175;1418.0428210957768;1418.5886093032905;1419.4464158978008;30066.398672026873;30101.296677388502;30393.696063039086;30838.845805771725;31251.68748312488;43544.782276088416;53665.7316713414;53754.73122634362;53822;53852.19221711599;577206;581398;582207;583472;584292.0785396046;26942.865285673448;27927.441451171268;42370.364444533974;42972.78513607412;43553;48334;49180.770480736835;49547.50452495429;49863.75340616514;50151.24773128333;39790.01049947549;40233.99415014531;40285.79857100813;41500.377494338216;41512;39794.204115918095;39918.60081399265;40700.38949415702;40821.591784082964;41402;38612.420813687255;39150.80424597973;39804.004899877735;39879.601203987586;39881.800590996856;32127;34441.311173776885;35157.82421087878;35199.82400087983;35314.646853531136;25733.485330293664;25751.841167147148;25990;26065.869670651526;26308.180693623 06:11:55 INFO - PROCESS | 1947 | |2;jquery.html;354.47537644286473;373.3988278871018;373.71597585834763;375.13718447570596;383.4822988964898;14959.401623935044;15635;20598.588028239446;20791.584168316625;21008.159673613038;20912.26807061753;21332.89333553334;21496.677549836764;21702.457438564004;21955.890220548914;5656.066748986413;5764.308283006035;5860.824175274727;5943.138244954479;5979.1330257112695;4077.9592204077876;5751.453611906883;5855.180274761516;5855.824325270249;5867.765289388441;6136.171616831715;6424.646644434578;6439.16290882187;6454.5159113066475;6497.122888410051;6173.783917562864;6361.268454127789;6433.774817881398;6468.029795530684;6481.319461456574;5593.664380137205;5610;5613.410591887834;5613.859653508654;5617.01702202113;23242.65136022961;24786;26364.472710545873;26514.73485265161;26558.6016209757;2316.5019520803107;2630.644862943497;2710.986445067782;3093.489574220251;3243.172990887332;15333.463328783439;15361;15631.92184039084;15636.374545018185;15743.527694169194;1504.5110339139824;1839.8528117750682;1841.6040551281405;1894.5926625775523;1942.77658069321;113438.43280783626;116356;116974.41512792467;117240;119107;9440.480773557383;9740.512974351395;10523.736906577244;10997.285176463503;11165.330080195214;13730.244836533886;13764;13768.931155344158;13774.311284435738;13784.241866697228;8340.040895296997;8587.613557389932;8591.484510929364;8709;8731.476111433334;6890.586564806128;8604.655813767378;8623.353248506388;8756.605952732143;8818.074102219303;5464.863378415572;6600.471962243009;6694.564853284521;6703.530752847351;6731.259561448237;1655.42887703742;1798.9777174346962;1826.53423377038;1843.8613091316247;1869.8597605179666;690.989635155473;698.3589055452463;829.3448175940939;934.2292608597934;1006.1498034161123;20672.79327206739;21894.01476933542;22603.095876165098;22819.543609127726;22960.851957402065;883.9911600884037;920.7110045935743;945.0832692288469;1003.7390278527636;1042.4579218806177;11124.33254004746;11706.414679266003;11858.466369013415;12072.396380180955;12147.210431321935;605662;615151.924240376;632946;634889;637819;78174.609126954;108486.45756771165;109794;111984.96067676974;121126;941.8493041113389;986.8914419413859;1005.7284533176148;1020.1940467031111;1021.6066814276409;15323.693526129193;20018.299359522345;20541.281055163;20736.170553177704;20805.271815486387;54371.18443223434;54529.45470545402;54909.450905490434;55716.16425753698;56033.87932241414;72213.638931805;73451.26548734444;74053.51892962218;74282;74961.62519187588;6043.909341359971;7917.960410198142;8062.072861620754;8116.391270654843;8144.267015968354;12701.682457938625;12996.472627991578;13315.334233288491;13370;13383.130096543693;11200.38397888124;11284.21010529255;11599.246049006788;11707.473163707824;11744.647660570197;7360.711875421673;11302.208845380745;11497.712557185803;11693.473793679135;11755.647330580096;10216.511142716805;11316.660500185008;11401.087912966777;11643.5342586299;11858.229215100991;6991.720331186899;7979.805553472841;8005.9599702001115;8158.877616835871;8235.711750088718;9419.62321507132;11239.426480292928;11550.364729939934;11598.826017609912;11687.590934317259 06:11:55 INFO - PROCESS | 1947 | |3;mootools.html;1349.5411560069574;1526.5267766992229;1695.4489790817988;1872.8969906655145;1894.1476335648954;8255.669773209072;8779;8790.516521591326;8800.603972821222;8818.955905220473;7719.614019299027;7967.123616402206;8371.995360556743;8570.357223208268;8614.138586141382;1920.9615807683838;2337.5091230841545;2339.87130707811;2346.378209774411;2346.7770561796688;2098.3495116513927;2185.8142057925015;2326.4416540030356;2352.0709319818748;2355.7762012608773;2317.687112239851;2339.415146213447;2350.576896158691;2354.0348457132577;2355.9882200588972;2324.1052194904914;2330.4057465346395;2337.7077865266842;2345.5074434368803;2349;2341.7775311345395;2343.5781559319316;2346.554154710617;2349.635806450003;2349.9412514687097;8353.498790072554;8515.829683406297;8517.872231916526;8518.659253629847;8522.318214542822;5115.565176959963;5295.576353891679;5295.576353891679;5300.549453296474;5302.575793936514;3362.226687861781;3414.7438942079443;3552.9163605100694;3554.893353199408;3580.964190358089;1047.2512153810062;1078.8705355357329;1086.8478413022183;1105.5135740274254;1108.7505311304972;11355.716107097389;11465.31208127515;11472.31166130035;11495.080393568494;11509.94245028778;4464.263396539534;4604.079184163181;4708.8116475341285;4719.787609557578;4725.740084295397;9768.658096966572;9773.706788796348;9788.314817962817;9794.118529332394;9820.067093626094;5238.397584277781;5240.764165612557;5248.976449592293;5253.527182553588;5265.420803711589;3647.2705458908326;4274.252005898955;4403.889902752457;4751.904961900743;4811.206150985048;3435.896923092311;3810.2189051244427;3914.8451206894033;3932.2332145231403;3962.0094976255937;1140.9771804563861;1230.446299165379;1262.8042653388738;1281.8525869524938;1295.3717447038368;800.2757504458474;848.4273115646913;856.7301300090452;861.909684249425;946.4888959961544;4266.847951053261;5492.176173573996;5560.4161563036105;5836.620619659709;6028.90956635642;944.2681921510884;961.6393852305386;963.9662611808693;971.1017308989157;1014.8680671512656;3835.2329137047573;3890.4747859038666;3999.6600288975765;4028;4048.655864251513;10088.092071713581;10542.947285263677;10544.89455105439;10547.156227501935;10548.578056877792;9888;10354.637587684394;10487.685369438928;10491;10498.632547860789;7665.9233407666325;7874.960625196952;7875.527468351803;7880.566568838769;7900.604969751489;5699.259096317618;5767.221425107557;5795.884082318415;5868.882622347443;6129.632222066691;9560.665376711782;9830.901690983284;9840.901590983998;9849.704508864745;9881.802363952824;8682.34882383811;9819.656312029045;9833;9936.056074672895;9936.403815771077;5197.66215196011;6874;7106.289371062852;7391.8152046199275;7538.924610754042;7874.488158269694;8165.918340816515;8182.549959752271;8184.345252379914;8185.4270201085355;7252.166000909963;7333.449991250571;7352.264773522605;7394.667239974106;7499.66251518672;7228.20489746117;7247.456440766858;7255.746048888263;7264.34620884123;7306.963465182853;6843.315668433117;6851.828704282233;6909;6919.515633905578;6928.203256625553;4823.155947709207;4882.780274887709;4891.828785992473;4920.8769780755765;5012.774425150804;4156.875293741193;4789.353437286061;4817.13291607514;4881.975590122027;4985.177445721561 06:11:55 INFO - PROCESS | 1947 | |4;prototype.html;255.29538473812278;302.629279133062;312.5170520216876;318.647894077045;319.4537341146639;5166.896662066766;5323.349761573915;5383.703896285702;5398.839249561343;5401.353336864932;4578.832397738572;4585.403897493321;4734.810607575701;5046.470120637336;5302.6213184572;3543.4153364694794;4090.1615168890307;4091.2635725569385;4100.949525237382;4111.979440102796;3351.782134161284;3854.903627409309;4108.506979162505;4113.465249517559;4136.73111247768;4010.578889216634;4014;4027.41602467642;4039.7172197946156;4051.513818341803;3995.9001024974464;4012.819423125937;4024.2756303865294;4028.207447685781;4036.979815100906;2873.5976963224957;3475.1138459692615;3486.407310757152;3498.352804731133;3511.3328467591077;4808.471068182497;5209.557187639055;5231.450697676727;5248.580113590903;5285.339332583427;3935.429362742415;4588.816447342102;4596.563326483979;4602.79287432063;4603.83886563972;4705.482566826731;5617.399041273258;5623.437656234385;5626.493615574577;5631.831045068655;3236.9352612947846;3351.581052368454;3642.9271414571826;3778.792166430845;3817.4655548223272;4988.5260900214425;5861.710423706778;5889.381614930457;5890.263717035371;5911.379305172981;3340.9643010666773;3801.3727734923427;3886.70849686269;3896.7467114638025;3918.6277303656107;2900.9854950725535;3517.771344862576;3776.4335349697217;3902.5316961964177;3916.8824935251987;4525.275955847049;4558.361829343895;4558.9772051139535;4568.474625418119;4582.427196600425;5610.97194514033;5626;5632.746526406239;5647.576431767634;5653.406392328829;1055.8310670292717;1097.2977294531506;1174.9647510574696;1297.4680381043727;1312.7965165399378;715.8246229673659;749.2806905370796;802.3340627279345;821.8890449789321;825.7729124490813;4354.864497561751;4369.825206991684;4381.890452738707;4384.956150438518;4389;4269.935950960676;4467.235442000391;4815.422149342101;4826.300186472942;4830.309391712873;3560.857565697395;4024.9798751006642;4046.9595304046584;4204.894877628022;4391.365180891439;2520.3069155982253;2539.2225442190543;2540.720520742717;2542.694876614781;2546.3761378462027;4072.515765383114;4223.366495025709;4648;4894.902101957941;4987.950120498748;4565.885852853705;5012.724300163526;5389.380221274525;6011.969940150271;6057.727402266909;5274.841754747364;6069.939300607026;6110.930587147232;6119.724612392542;6132.540059495555;5165.61257905651;5256.868578285574;5545.584081194007;5824.592278540462;5887.20522729426;4902.264660300841;5807.912881306699;5819.621724587888;5821;5824.941905499647;5235.712035838065;5532.861678458071;5607.43925607436;6069.695015571673;6074.453299203093;3523.9119022024656;3899.994553080251;3967.484227050465;4004;4042.543625200529;5624.484697064335;5784.623999440023;5793.449622286044;5804.506616937439;5808.82573522795;4713.266305542708;5339.572834173179;5623.662580245198;5629.831105066854;5635;4996.875078123076;5509.029178763009;5579.386267510489;5618.578606604439;5628.577856660685;5273.338898247193;5444.646098003617;5468.699221542854;5496.560275178056;5505.752241149078;5007.649464537593;5137.8201762938115;5448.809291674773;5450.400455949922;5702.830919661543;5550.306211723535;5554.2779438672715;5556.305461817273;5562.16567514876;5570.3315602128005 06:11:55 INFO - PROCESS | 1947 | |5;yui.html;704.4786857725281;727.261829243318;752.8833030880209;761.8209720715635;876.163264082801;14743.11541307521;15877.841221587782;16416.917915410435;16436.0960147192;16638.83361166388;14480.275986200673;14922.03006804557;14924.850751492482;14932.626684332898;14948.103113813178;679.4055201698513;702.1679310017646;870.1168314161147;881.5988725130051;884.5665623844302;849.2399302624148;879.3404946290283;886.9822603547925;887.4719541872576;888.595688961521;931.7437704631213;933.1415098109721;935.5135329628623;936.6253498600546;938.7746940734243;713.201214639607;749.8837680159584;929.7117893453051;930.6882194464862;931.5668214280358;602.8553147244629;669.0900375489331;684.2541629623685;686.9175698916162;688;15112.168830714307;15115.622109447242;15157.090574565562;15160;15171.241437928169;11426.714332141762;14156.36296366666;14246.216458094801;14429.35067921946;14465.421383144661;10934.507947142318;12938.741225175538;12951.611451656465;13221.206727596375;13328.13367131143;4531.889687026666;4585.256651544264;4650.604698600623;4747.548982846624;4748.3589715388325;93642;93683;119061;120299;120320.99999999913;10538.683839484827;11002;11299.152563557602;11343.659690209306;11363.261388009752;22083.558328833333;22176.1129554816;22267.331980040624;22271.44321391978;22309.219177328716;7918.326942209861;8011.879821802678;8087.878681819778;8140.470869393471;8197.508149511048;3852.6339997700175;4396.406485124531;4424.690271680952;4459.2865141577195;4488.349189367524;3411.334789716031;3526.206603514189;3558.7508874378545;3565.893023209256;3566.32239874423;637.2512298049772;639.8912184928573;640.6220330005319;660.5112216959416;660.600336796241;612.4640939178219;613.1354789746437;630.4357599948021;646.1277275677797;648.1703419622891;8965.731028069038;9052.818943621223;9131.908680913106;9133.269338452908;9278.536073196314;493.2207112761828;539.1831375466094;596.9910451343234;599.8470390050509;645.2128403347908;3819.312523745697;4468.709533880287;4472.239719247736;4474.709143905636;4528.954710452853;149928;154655;156521;156961.4303856947;161039.19480402523;116664;117939.41030294965;121282;135166;142844;80292.59853700694;91557;92345;102335;109984.4500777491;9737.318387713076;9955.153811925778;9963.850542242017;9993.750156245862;10027.29808913369;61249.08126378197;63787.36212637814;64439.67780161069;65528.34471655222;67248.66375668091;77937;90551;94042;97342;98002;12473.87526124727;12973;13109.672258193621;13247.735045299232;13317.933410333273;14642.341094650554;14692.265386730835;14802.380131596645;14812.925935370255;14991.925040375165;13776.862231377558;13893.235872027135;13985.510507132201;14039.578812635229;14370.568882933529;11510.712232194262;13659.248741319323;13949.442022318994;14167.504137355143;14402.85597144015;13408.798868017182;13586;13659.86340136586;13674.863251367358;13736.244506552235;9225.358777789625;10601.41692206936;10749.635080282325;11728.530858765895;11973.16187866841;9999.750006249902;11418.657440276806;11570.305781653127;11624.186306958432;11688 06:11:55 INFO - PROCESS | 1947 | __end_tp_report 06:11:55 INFO - PROCESS | 1947 | __start_cc_report 06:11:55 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1227 06:11:55 INFO - PROCESS | 1947 | __end_cc_report 06:11:55 INFO - PROCESS | 1947 | __startTimestamp1470661915037__endTimestamp 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | ------- Summary: start ------- 06:11:55 INFO - PROCESS | 1947 | Number of tests: 6 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5718.31 Median:5916.08 stddev:669.21 (11.3%) stddev-sans-first:643.71 06:11:55 INFO - PROCESS | 1947 | Values: 3295.6 3313.1 3325.5 3343.5 3353.2 5521.3 5636.1 5675.0 5684.2 5691.7 5677.5 5719.9 5724.5 5738.7 5739.9 5165.0 5189.8 5217.9 5228.8 5291.9 5232.1 5245.9 5247.5 5250.6 5267.4 4165.4 5158.5 5164.8 5183.4 5245.5 5239.6 5262.8 5272.4 5274.0 5333.0 4055.8 5074.8 5107.4 5173.9 5175.2 5610.6 5628.4 5653.9 5655.7 5700.1 6268.6 6277.4 6303.3 6303.7 6304.0 4539.7 6105.4 6144.8 6217.8 6260.6 5783.2 5795.2 5803.3 5806.2 5823.9 6231.5 6239.0 6239.4 6250.2 6267.3 5969.8 6109.4 6117.3 6170.1 6177.9 6245.2 6263.4 6269.0 6286.4 6294.2 6213.2 6254.2 6260.4 6270.5 6281.2 6119.9 6143.5 6145.1 6154.6 6214.8 4893.8 4939.9 4940.9 4953.2 4981.4 4427.0 4476.8 4509.9 4512.5 4513.6 5682.6 5745.4 5765.5 5766.6 5787.3 5487.8 5880.0 6249.3 6258.5 6282.6 5525.9 5578.8 5710.6 5722.5 5723.6 5329.8 5411.6 5414.4 5423.9 5424.9 6247.4 6316.3 6326.2 6401.5 6410.6 6284.0 6292.2 6296.3 6306.9 6323.0 6380.8 6395.1 6402.6 6403.5 6412.6 6041.8 6093.8 6107.6 6113.5 6143.7 5075.3 6146.7 6210.0 6273.0 6284.8 6131.2 6142.0 6153.6 6167.2 6169.8 6099.2 6132.1 6139.3 6142.2 6156.8 5790.0 5811.5 5879.5 5916.1 6027.1 6132.8 6135.7 6142.5 6148.6 6169.7 5967.1 6010.3 6026.9 6036.1 6048.3 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:72801.04 Median:42351.18 stddev:157570.05 (372.1%) stddev-sans-first:157918.55 06:11:55 INFO - PROCESS | 1947 | Values: 492.2 511.0 523.3 536.8 556.0 30589.5 41060.6 42178.6 42332.0 44344.2 43822.8 44150.6 44197.8 44227.3 44267.8 9719.8 9947.2 9949.4 9954.7 9959.2 9766.4 9875.4 9885.9 9888.1 9891.5 9850.7 9915.3 9923.6 9943.7 9944.1 9832.3 9882.2 9885.0 9902.7 9902.9 9696.6 9785.6 9787.5 9790.6 9829.7 41441.6 41804.6 41817.4 41822.7 41854.8 3447.3 3981.0 4071.0 4164.3 4348.8 31767.7 32371.5 33143.7 33324.7 33514.3 3228.4 3311.6 3322.2 3379.0 3415.1 518738.4 523245.0 525225.0 526542.0 526642.7 63054.7 63542.0 63549.0 63617.7 63733.4 66441.0 66565.7 66572.0 66625.7 66648.7 16681.3 16950.2 16956.6 16964.7 16976.7 12991.5 13072.5 13073.8 13074.5 13082.0 13251.3 17725.6 17841.5 17866.3 17930.8 6040.5 6042.5 6047.2 6119.5 6162.6 918.5 946.6 976.3 1064.1 1085.6 30986.0 31056.0 31249.8 31509.8 31657.2 965.3 1066.6 1103.9 1135.2 1152.4 12736.7 15712.5 15981.5 16122.5 16491.9 655239.0 656086.0 656330.0 656463.0 660215.0 58840.0 59133.0 59661.4 59752.0 59824.0 1365.0 1389.8 1418.0 1418.6 1419.4 30066.4 30101.3 30393.7 30838.8 31251.7 43544.8 53665.7 53754.7 53822.0 53852.2 577206.0 581398.0 582207.0 583472.0 584292.1 26942.9 27927.4 42370.4 42972.8 43553.0 48334.0 49180.8 49547.5 49863.8 50151.2 39790.0 40234.0 40285.8 41500.4 41512.0 39794.2 39918.6 40700.4 40821.6 41402.0 38612.4 39150.8 39804.0 39879.6 39881.8 32127.0 34441.3 35157.8 35199.8 35314.6 25733.5 25751.8 25990.0 26065.9 26308.2 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:35316.07 Median:26439.60 stddev:103563.27 (391.7%) stddev-sans-first:103820.52 06:11:55 INFO - PROCESS | 1947 | Values: 354.5 373.4 373.7 375.1 383.5 14959.4 15635.0 20598.6 20791.6 21008.2 20912.3 21332.9 21496.7 21702.5 21955.9 5656.1 5764.3 5860.8 5943.1 5979.1 4078.0 5751.5 5855.2 5855.8 5867.8 6136.2 6424.6 6439.2 6454.5 6497.1 6173.8 6361.3 6433.8 6468.0 6481.3 5593.7 5610.0 5613.4 5613.9 5617.0 23242.7 24786.0 26364.5 26514.7 26558.6 2316.5 2630.6 2711.0 3093.5 3243.2 15333.5 15361.0 15631.9 15636.4 15743.5 1504.5 1839.9 1841.6 1894.6 1942.8 113438.4 116356.0 116974.4 117240.0 119107.0 9440.5 9740.5 10523.7 10997.3 11165.3 13730.2 13764.0 13768.9 13774.3 13784.2 8340.0 8587.6 8591.5 8709.0 8731.5 6890.6 8604.7 8623.4 8756.6 8818.1 5464.9 6600.5 6694.6 6703.5 6731.3 1655.4 1799.0 1826.5 1843.9 1869.9 691.0 698.4 829.3 934.2 1006.1 20672.8 21894.0 22603.1 22819.5 22960.9 884.0 920.7 945.1 1003.7 1042.5 11124.3 11706.4 11858.5 12072.4 12147.2 605662.0 615151.9 632946.0 634889.0 637819.0 78174.6 108486.5 109794.0 111985.0 121126.0 941.8 986.9 1005.7 1020.2 1021.6 15323.7 20018.3 20541.3 20736.2 20805.3 54371.2 54529.5 54909.5 55716.2 56033.9 72213.6 73451.3 74053.5 74282.0 74961.6 6043.9 7918.0 8062.1 8116.4 8144.3 12701.7 12996.5 13315.3 13370.0 13383.1 11200.4 11284.2 11599.2 11707.5 11744.6 7360.7 11302.2 11497.7 11693.5 11755.6 10216.5 11316.7 11401.1 11643.5 11858.2 6991.7 7979.8 8006.0 8158.9 8235.7 9419.6 11239.4 11550.4 11598.8 11687.6 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5563.89 Median:5064.17 stddev:3110.25 (61.4%) stddev-sans-first:3102.85 06:11:55 INFO - PROCESS | 1947 | Values: 1349.5 1526.5 1695.4 1872.9 1894.1 8255.7 8779.0 8790.5 8800.6 8819.0 7719.6 7967.1 8372.0 8570.4 8614.1 1921.0 2337.5 2339.9 2346.4 2346.8 2098.3 2185.8 2326.4 2352.1 2355.8 2317.7 2339.4 2350.6 2354.0 2356.0 2324.1 2330.4 2337.7 2345.5 2349.0 2341.8 2343.6 2346.6 2349.6 2349.9 8353.5 8515.8 8517.9 8518.7 8522.3 5115.6 5295.6 5295.6 5300.5 5302.6 3362.2 3414.7 3552.9 3554.9 3581.0 1047.3 1078.9 1086.8 1105.5 1108.8 11355.7 11465.3 11472.3 11495.1 11509.9 4464.3 4604.1 4708.8 4719.8 4725.7 9768.7 9773.7 9788.3 9794.1 9820.1 5238.4 5240.8 5249.0 5253.5 5265.4 3647.3 4274.3 4403.9 4751.9 4811.2 3435.9 3810.2 3914.8 3932.2 3962.0 1141.0 1230.4 1262.8 1281.9 1295.4 800.3 848.4 856.7 861.9 946.5 4266.8 5492.2 5560.4 5836.6 6028.9 944.3 961.6 964.0 971.1 1014.9 3835.2 3890.5 3999.7 4028.0 4048.7 10088.1 10542.9 10544.9 10547.2 10548.6 9888.0 10354.6 10487.7 10491.0 10498.6 7665.9 7875.0 7875.5 7880.6 7900.6 5699.3 5767.2 5795.9 5868.9 6129.6 9560.7 9830.9 9840.9 9849.7 9881.8 8682.3 9819.7 9833.0 9936.1 9936.4 5197.7 6874.0 7106.3 7391.8 7538.9 7874.5 8165.9 8182.5 8184.3 8185.4 7252.2 7333.4 7352.3 7394.7 7499.7 7228.2 7247.5 7255.7 7264.3 7307.0 6843.3 6851.8 6909.0 6919.5 6928.2 4823.2 4882.8 4891.8 4920.9 5012.8 4156.9 4789.4 4817.1 4882.0 4985.2 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4414.42 Median:4771.64 stddev:1408.73 (29.5%) stddev-sans-first:1377.66 06:11:55 INFO - PROCESS | 1947 | Values: 255.3 302.6 312.5 318.6 319.5 5166.9 5323.3 5383.7 5398.8 5401.4 4578.8 4585.4 4734.8 5046.5 5302.6 3543.4 4090.2 4091.3 4100.9 4112.0 3351.8 3854.9 4108.5 4113.5 4136.7 4010.6 4014.0 4027.4 4039.7 4051.5 3995.9 4012.8 4024.3 4028.2 4037.0 2873.6 3475.1 3486.4 3498.4 3511.3 4808.5 5209.6 5231.5 5248.6 5285.3 3935.4 4588.8 4596.6 4602.8 4603.8 4705.5 5617.4 5623.4 5626.5 5631.8 3236.9 3351.6 3642.9 3778.8 3817.5 4988.5 5861.7 5889.4 5890.3 5911.4 3341.0 3801.4 3886.7 3896.7 3918.6 2901.0 3517.8 3776.4 3902.5 3916.9 4525.3 4558.4 4559.0 4568.5 4582.4 5611.0 5626.0 5632.7 5647.6 5653.4 1055.8 1097.3 1175.0 1297.5 1312.8 715.8 749.3 802.3 821.9 825.8 4354.9 4369.8 4381.9 4385.0 4389.0 4269.9 4467.2 4815.4 4826.3 4830.3 3560.9 4025.0 4047.0 4204.9 4391.4 2520.3 2539.2 2540.7 2542.7 2546.4 4072.5 4223.4 4648.0 4894.9 4988.0 4565.9 5012.7 5389.4 6012.0 6057.7 5274.8 6069.9 6110.9 6119.7 6132.5 5165.6 5256.9 5545.6 5824.6 5887.2 4902.3 5807.9 5819.6 5821.0 5824.9 5235.7 5532.9 5607.4 6069.7 6074.5 3523.9 3900.0 3967.5 4004.0 4042.5 5624.5 5784.6 5793.4 5804.5 5808.8 4713.3 5339.6 5623.7 5629.8 5635.0 4996.9 5509.0 5579.4 5618.6 5628.6 5273.3 5444.6 5468.7 5496.6 5505.8 5007.6 5137.8 5448.8 5450.4 5702.8 5550.3 5554.3 5556.3 5562.2 5570.3 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:24747.40 Median:4124.52 stddev:39388.91 (955.0%) stddev-sans-first:39458.04 06:11:55 INFO - PROCESS | 1947 | Values: 704.5 727.3 752.9 761.8 876.2 14743.1 15877.8 16416.9 16436.1 16638.8 14480.3 14922.0 14924.9 14932.6 14948.1 679.4 702.2 870.1 881.6 884.6 849.2 879.3 887.0 887.5 888.6 931.7 933.1 935.5 936.6 938.8 713.2 749.9 929.7 930.7 931.6 602.9 669.1 684.3 686.9 688.0 15112.2 15115.6 15157.1 15160.0 15171.2 11426.7 14156.4 14246.2 14429.4 14465.4 10934.5 12938.7 12951.6 13221.2 13328.1 4531.9 4585.3 4650.6 4747.5 4748.4 93642.0 93683.0 119061.0 120299.0 120321.0 10538.7 11002.0 11299.2 11343.7 11363.3 22083.6 22176.1 22267.3 22271.4 22309.2 7918.3 8011.9 8087.9 8140.5 8197.5 3852.6 4396.4 4424.7 4459.3 4488.3 3411.3 3526.2 3558.8 3565.9 3566.3 637.3 639.9 640.6 660.5 660.6 612.5 613.1 630.4 646.1 648.2 8965.7 9052.8 9131.9 9133.3 9278.5 493.2 539.2 597.0 599.8 645.2 3819.3 4468.7 4472.2 4474.7 4529.0 149928.0 154655.0 156521.0 156961.4 161039.2 116664.0 117939.4 121282.0 135166.0 142844.0 80292.6 91557.0 92345.0 102335.0 109984.5 9737.3 9955.2 9963.9 9993.8 10027.3 61249.1 63787.4 64439.7 65528.3 67248.7 77937.0 90551.0 94042.0 97342.0 98002.0 12473.9 12973.0 13109.7 13247.7 13317.9 14642.3 14692.3 14802.4 14812.9 14991.9 13776.9 13893.2 13985.5 14039.6 14370.6 11510.7 13659.2 13949.4 14167.5 14402.9 13408.8 13586.0 13659.9 13674.9 13736.2 9225.4 10601.4 10749.6 11728.5 11973.2 9999.8 11418.7 11570.3 11624.2 11688.0 06:11:55 INFO - PROCESS | 1947 | -------- Summary: end -------- 06:11:55 INFO - PROCESS | 1947 | 06:11:55 INFO - TEST-INFO | 1947: exit 0 06:11:55 INFO - TEST-OK | dromaeo_css | took 1117958ms 06:11:55 INFO - TEST-START | kraken 06:11:55 INFO - operating with platform_type : mac_ 06:11:55 INFO - Initialising browser for kraken test... 06:11:55 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpCGaKlb/profile http://localhost:49391/getInfo.html) 06:11:58 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 06:11:58 INFO - PROCESS | 1950 | colorDepth:24 06:11:58 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 06:11:58 INFO - PROCESS | 1950 | __metrics 06:11:58 INFO - PROCESS | 1950 | 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" 06:11:58 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:59 INFO - TEST-INFO | 1950: exit 0 06:11:59 INFO - Browser initialized. 06:11:59 INFO - Running cycle 1/1 for kraken test... 06:11:59 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpCGaKlb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:11 INFO - PROCESS | 1951 | RSS: Main: 243814400 06:12:11 INFO - PROCESS | 1951 | 06:12:14 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:15 INFO - PROCESS | 1951 | RSS: Main: 294924288 06:12:15 INFO - PROCESS | 1951 | 06:12:17 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-dft) 06:12:18 INFO - PROCESS | 1951 | RSS: Main: 302256128 06:12:18 INFO - PROCESS | 1951 | 06:12:21 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-fft) 06:12:22 INFO - PROCESS | 1951 | RSS: Main: 397348864 06:12:22 INFO - PROCESS | 1951 | 06:12:24 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator) 06:12:25 INFO - PROCESS | 1951 | RSS: Main: 298684416 06:12:25 INFO - PROCESS | 1951 | 06:12:27 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:27 INFO - PROCESS | 1951 | RSS: Main: 302960640 06:12:27 INFO - PROCESS | 1951 | 06:12:30 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:31 INFO - PROCESS | 1951 | RSS: Main: 339697664 06:12:31 INFO - PROCESS | 1951 | 06:12:33 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:34 INFO - PROCESS | 1951 | RSS: Main: 340635648 06:12:34 INFO - PROCESS | 1951 | 06:12:37 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial) 06:12:37 INFO - PROCESS | 1951 | RSS: Main: 340758528 06:12:37 INFO - PROCESS | 1951 | 06:12:39 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:40 INFO - PROCESS | 1951 | RSS: Main: 315351040 06:12:40 INFO - PROCESS | 1951 | 06:12:42 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:42 INFO - PROCESS | 1951 | RSS: Main: 319627264 06:12:42 INFO - PROCESS | 1951 | 06:12:44 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:45 INFO - PROCESS | 1951 | RSS: Main: 323866624 06:12:45 INFO - PROCESS | 1951 | 06:12:48 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:49 INFO - PROCESS | 1951 | RSS: Main: 329707520 06:12:49 INFO - PROCESS | 1951 | 06:12:51 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:52 INFO - PROCESS | 1951 | RSS: Main: 330940416 06:12:52 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49391/tests/kraken/driver.html?testName=ai-astar) 06:12:54 INFO - PROCESS | 1951 | RSS: Main: 374579200 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | __start_tp_report 06:12:54 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 06:12:54 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 06:12:54 INFO - PROCESS | 1951 | |i|pagename|runs| 06:12:54 INFO - PROCESS | 1951 | |0;ai-astar;102;114;113;114;116;165;150;114;112;113 06:12:54 INFO - PROCESS | 1951 | |1;audio-beat-detection;142;108;106;166;108;107;131;105;141;106 06:12:54 INFO - PROCESS | 1951 | |2;audio-dft;184;183;186;185;183;196;237;182;183;184 06:12:54 INFO - PROCESS | 1951 | |3;audio-fft;78;57;61;89;60;58;64;63;83;57 06:12:54 INFO - PROCESS | 1951 | |4;audio-oscillator;84;69;99;69;77;100;130;100;67;97 06:12:54 INFO - PROCESS | 1951 | |5;imaging-gaussian-blur;88;83;87;84;91;83;88;83;89;84 06:12:54 INFO - PROCESS | 1951 | |6;imaging-darkroom;97;94;94;93;93;94;93;94;93;94 06:12:54 INFO - PROCESS | 1951 | |7;imaging-desaturate;84;86;85;86;87;85;84;85;85;89 06:12:54 INFO - PROCESS | 1951 | |8;json-parse-financial;54;53;56;56;54;54;53;53;54;53 06:12:54 INFO - PROCESS | 1951 | |9;json-stringify-tinderbox;68;73;73;67;76;73;70;71;72;72 06:12:54 INFO - PROCESS | 1951 | |10;stanford-crypto-aes;84;86;81;85;80;85;83;84;87;83 06:12:54 INFO - PROCESS | 1951 | |11;stanford-crypto-ccm;138;136;132;148;149;134;135;140;143;151 06:12:54 INFO - PROCESS | 1951 | |12;stanford-crypto-pbkdf2;167;171;169;168;168;168;160;167;166;166 06:12:54 INFO - PROCESS | 1951 | |13;stanford-crypto-sha256-iterative;67;67;68;68;67;66;68;67;66;66 06:12:54 INFO - PROCESS | 1951 | __end_tp_report 06:12:54 INFO - PROCESS | 1951 | __start_cc_report 06:12:54 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,2059 06:12:54 INFO - PROCESS | 1951 | __end_cc_report 06:12:54 INFO - PROCESS | 1951 | __startTimestamp1470661974480__endTimestamp 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | ------- Summary: start ------- 06:12:54 INFO - PROCESS | 1951 | Number of tests: 14 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#0] ai-astar Cycles:10 Average:121.30 Median:114.00 stddev:19.77 (17.3%) stddev-sans-first:19.70 06:12:54 INFO - PROCESS | 1951 | Values: 102.0 114.0 113.0 114.0 116.0 165.0 150.0 114.0 112.0 113.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:119.50 stddev:21.59 (18.1%) stddev-sans-first:21.66 06:12:54 INFO - PROCESS | 1951 | Values: 142.0 108.0 106.0 166.0 108.0 107.0 131.0 105.0 141.0 106.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#2] audio-dft Cycles:10 Average:190.30 Median:184.50 stddev:16.89 (9.2%) stddev-sans-first:17.76 06:12:54 INFO - PROCESS | 1951 | Values: 184.0 183.0 186.0 185.0 183.0 196.0 237.0 182.0 183.0 184.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#3] audio-fft Cycles:10 Average:67.00 Median:63.50 stddev:11.79 (18.6%) stddev-sans-first:11.82 06:12:54 INFO - PROCESS | 1951 | Values: 78.0 57.0 61.0 89.0 60.0 58.0 64.0 63.0 83.0 57.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:73.00 stddev:19.83 (27.2%) stddev-sans-first:20.95 06:12:54 INFO - PROCESS | 1951 | Values: 84.0 69.0 99.0 69.0 77.0 100.0 130.0 100.0 67.0 97.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.50 stddev:2.94 (3.4%) stddev-sans-first:3.03 06:12:54 INFO - PROCESS | 1951 | Values: 88.0 83.0 87.0 84.0 91.0 83.0 88.0 83.0 89.0 84.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:1.20 (1.3%) stddev-sans-first:0.53 06:12:54 INFO - PROCESS | 1951 | Values: 97.0 94.0 94.0 93.0 93.0 94.0 93.0 94.0 93.0 94.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:1.51 (1.8%) stddev-sans-first:1.48 06:12:54 INFO - PROCESS | 1951 | Values: 84.0 86.0 85.0 86.0 87.0 85.0 84.0 85.0 85.0 89.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 06:12:54 INFO - PROCESS | 1951 | Values: 54.0 53.0 56.0 56.0 54.0 54.0 53.0 53.0 54.0 53.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.50 stddev:2.64 (3.6%) stddev-sans-first:2.47 06:12:54 INFO - PROCESS | 1951 | Values: 68.0 73.0 73.0 67.0 76.0 73.0 70.0 71.0 72.0 72.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.50 stddev:2.15 (2.5%) stddev-sans-first:2.28 06:12:54 INFO - PROCESS | 1951 | Values: 84.0 86.0 81.0 85.0 80.0 85.0 83.0 84.0 87.0 83.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:141.50 stddev:6.80 (4.8%) stddev-sans-first:7.15 06:12:54 INFO - PROCESS | 1951 | Values: 138.0 136.0 132.0 148.0 149.0 134.0 135.0 140.0 143.0 151.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.00 stddev:2.87 (1.7%) stddev-sans-first:3.04 06:12:54 INFO - PROCESS | 1951 | Values: 167.0 171.0 169.0 168.0 168.0 168.0 160.0 167.0 166.0 166.0 06:12:54 INFO - PROCESS | 1951 | 06:12:54 INFO - PROCESS | 1951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 06:12:54 INFO - PROCESS | 1951 | Values: 67.0 67.0 68.0 68.0 67.0 66.0 68.0 67.0 66.0 66.0 06:12:54 INFO - PROCESS | 1951 | -------- Summary: end -------- 06:12:54 INFO - PROCESS | 1951 | 06:12:55 INFO - TEST-INFO | 1951: exit 0 06:12:55 INFO - TEST-OK | kraken | took 59534ms 06:12:55 INFO - SUITE-END | took 1177s 06:12:55 INFO - Completed test suite (00:19:37) 06:12:55 INFO - javascript benchmark 06:12:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.5715756951595, 3313.122022663994, 3325.4679251319785, 3343.465045592706, 3353.228757385801, 5521.337439507255, 5636.070048442008, 5675.0, 5684.204211410406, 5691.658500489968, 5677.517411020068, 5719.942800571993, 5724.542036637069, 5738.713064346787, 5739.913901291484, 5164.9741751291285, 5189.766460509267, 5217.947820521784, 5228.764705588258, 5291.920621190685, 5232.110541207985, 5245.8950820983555, 5247.527722504974, 5250.606204534656, 5267.394249661281, 4165.437665915093, 5158.458361872005, 5164.767585458663, 5183.403908550508, 5245.501677340647, 5239.633225674185, 5262.789488420459, 5272.367315922113, 5273.9736301318635, 5332.9733351333, 4055.7566546007333, 5074.797008119671, 5107.412647545506, 5173.948260517422, 5175.171972484384, 5610.551155907518, 5628.352739434977, 5653.943460565383, 5655.688937108457, 5700.144978253295, 6268.561200715952, 6277.403646653561, 6303.306636270053, 6303.684815759239, 6304.0, 4539.727616342997, 6105.429421494191, 6144.771045790815, 6217.813465596039, 6260.561760676755, 5783.161441590946, 5795.159701843209, 5803.303603567514, 5806.187133801272, 5823.854403639943, 6231.501479881598, 6239.001759718423, 6239.376062393724, 6250.15622890913, 6267.310595834455, 5969.820905372846, 6109.434037704175, 6117.296510901214, 6170.074488826712, 6177.938220617736, 6245.219347581552, 6263.373662633791, 6269.0, 6286.434220920048, 6294.244690637152, 6213.1922850029205, 6254.15568898202, 6260.373962603794, 6270.498360131179, 6281.214848143982, 6119.908201376983, 6143.542582966849, 6145.095020543646, 6154.599951003171, 6214.751409943642, 4893.779779909913, 4939.87650308738, 4940.8764780880765, 4953.23224900141, 4981.402231732143, 4426.955730442719, 4476.776161191992, 4509.864704058883, 4512.458504979358, 4513.593776560059, 5682.602217844794, 5745.396733343023, 5765.538756899438, 5766.625169364062, 5787.305523337226, 5487.75305111271, 5879.970600147058, 6249.312575616678, 6258.468030217483, 6282.623042617458, 5525.944740552623, 5578.832635020955, 5710.5717071219, 5722.54219662426, 5723.59934804568, 5329.760160792774, 5411.648242864201, 5414.35027796667, 5423.864403389947, 5424.864378390572, 6247.406496382836, 6316.30520642729, 6326.177596912372, 6401.455876250385, 6410.61536307823, 6283.96858015707, 6292.1505596743855, 6296.33888441707, 6306.873862522632, 6323.0, 6380.840478988062, 6395.104685343963, 6402.583832050902, 6403.455706265019, 6412.61524308543, 6041.848953776015, 6093.75624974996, 6107.603005804608, 6113.506711826627, 6143.723532440961, 5075.264086707481, 6146.723397447215, 6209.96895015522, 6273.0, 6284.811455656338, 6131.188896256383, 6142.04798256271, 6153.6000159991245, 6167.229096362955, 6169.784057557964, 6099.167614827221, 6132.110843927695, 6139.26328840542, 6142.201513803177, 6156.846078848064, 5790.044642633919, 5811.506021988178, 5879.470847623735, 5916.083007133901, 6027.065804800263, 6132.753252973555, 6135.662538560422, 6142.464383904024, 6148.569600127948, 6169.722362493609, 5967.1049342597225, 6010.33886272501, 6026.909596356146, 6036.094585812163, 6048.274207095177], "value": 5675.62575184281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.2296605811904, 510.98722531936704, 523.3301374240968, 536.7772374464597, 556.0380541662925, 30589.54115688264, 41060.589394106086, 42178.57821421789, 42332.0, 44344.22623095072, 43822.78088609553, 44150.55849441505, 44197.779011104976, 44227.33658995118, 44267.77866110665, 9719.805603887919, 9947.1544918682, 9949.353292035994, 9954.65158719445, 9959.203263738884, 9766.365186262905, 9875.407475551454, 9885.90114098857, 9888.11007009369, 9891.455969921652, 9850.704478865646, 9915.25635577331, 9923.603055877757, 9943.701688949342, 9944.105030547249, 9832.31173817833, 9882.160016398542, 9885.01149885013, 9902.702918912444, 9902.851457228111, 9696.563654635558, 9785.559649815705, 9787.531870219453, 9790.608375664964, 9829.655962041294, 41441.58558414438, 41804.58195418037, 41817.37273940894, 41822.74531764021, 41854.79072604648, 3447.3277710846396, 3980.980095099506, 4070.9619047143087, 4164.312888373445, 4348.804303806336, 31767.682323176705, 32371.514427283608, 33143.6685633143, 33324.6667533324, 33514.32971340584, 3228.4350238708134, 3311.569495965509, 3322.18606441421, 3379.0, 3415.1462134466383, 518738.4063079698, 523245.0, 525225.0, 526542.0, 526642.7335726632, 63054.68472657607, 63542.046869296995, 63549.0, 63617.681911590145, 63733.36266637367, 66441.0, 66565.6671716648, 66572.0, 66625.66748665097, 66648.6670266592, 16681.332746690237, 16950.23723932426, 16956.576085597957, 16964.74552881708, 16976.660466790843, 12991.480340786451, 13072.477100916047, 13073.803892941614, 13074.477020919247, 13082.0, 13251.337433128305, 17725.645487090187, 17841.46475605734, 17866.28534858617, 17930.820691793175, 6040.486558642477, 6042.456178943916, 6047.183630209865, 6119.4798442132915, 6162.630242185483, 918.4810582021137, 946.6024269806697, 976.3409698453515, 1064.095518809006, 1085.5983286184005, 30986.0, 31056.0, 31249.8437507811, 31509.8424507876, 31657.208569785478, 965.2712202287228, 1066.6160182334354, 1103.9282446640943, 1135.1713249328036, 1152.4180288954192, 12736.745265094647, 15712.450064247696, 15981.520554383387, 16122.516324510283, 16491.91754041222, 655239.0, 656086.0, 656330.0, 656463.0, 660215.0, 58840.0, 59133.0, 59661.40338596558, 59752.0, 59824.0, 1364.9590512284647, 1389.8123753293175, 1418.0428210957768, 1418.5886093032905, 1419.4464158978008, 30066.398672026873, 30101.296677388502, 30393.696063039086, 30838.845805771725, 31251.68748312488, 43544.782276088416, 53665.7316713414, 53754.73122634362, 53822.0, 53852.19221711599, 577206.0, 581398.0, 582207.0, 583472.0, 584292.0785396046, 26942.865285673448, 27927.441451171268, 42370.364444533974, 42972.78513607412, 43553.0, 48334.0, 49180.770480736835, 49547.50452495429, 49863.75340616514, 50151.24773128333, 39790.01049947549, 40233.99415014531, 40285.79857100813, 41500.377494338216, 41512.0, 39794.204115918095, 39918.60081399265, 40700.38949415702, 40821.591784082964, 41402.0, 38612.420813687255, 39150.80424597973, 39804.004899877735, 39879.601203987586, 39881.800590996856, 32127.0, 34441.311173776885, 35157.82421087878, 35199.82400087983, 35314.646853531136, 25733.485330293664, 25751.841167147148, 25990.0, 26065.869670651526, 26308.180693623], "value": 20663.54180058135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.47537644286473, 373.3988278871018, 373.71597585834763, 375.13718447570596, 383.4822988964898, 14959.401623935044, 15635.0, 20598.588028239446, 20791.584168316625, 21008.159673613038, 20912.26807061753, 21332.89333553334, 21496.677549836764, 21702.457438564004, 21955.890220548914, 5656.066748986413, 5764.308283006035, 5860.824175274727, 5943.138244954479, 5979.1330257112695, 4077.9592204077876, 5751.453611906883, 5855.180274761516, 5855.824325270249, 5867.765289388441, 6136.171616831715, 6424.646644434578, 6439.16290882187, 6454.5159113066475, 6497.122888410051, 6173.783917562864, 6361.268454127789, 6433.774817881398, 6468.029795530684, 6481.319461456574, 5593.664380137205, 5610.0, 5613.410591887834, 5613.859653508654, 5617.01702202113, 23242.65136022961, 24786.0, 26364.472710545873, 26514.73485265161, 26558.6016209757, 2316.5019520803107, 2630.644862943497, 2710.986445067782, 3093.489574220251, 3243.172990887332, 15333.463328783439, 15361.0, 15631.92184039084, 15636.374545018185, 15743.527694169194, 1504.5110339139824, 1839.8528117750682, 1841.6040551281405, 1894.5926625775523, 1942.77658069321, 113438.43280783626, 116356.0, 116974.41512792467, 117240.0, 119107.0, 9440.480773557383, 9740.512974351395, 10523.736906577244, 10997.285176463503, 11165.330080195214, 13730.244836533886, 13764.0, 13768.931155344158, 13774.311284435738, 13784.241866697228, 8340.040895296997, 8587.613557389932, 8591.484510929364, 8709.0, 8731.476111433334, 6890.586564806128, 8604.655813767378, 8623.353248506388, 8756.605952732143, 8818.074102219303, 5464.863378415572, 6600.471962243009, 6694.564853284521, 6703.530752847351, 6731.259561448237, 1655.42887703742, 1798.9777174346962, 1826.53423377038, 1843.8613091316247, 1869.8597605179666, 690.989635155473, 698.3589055452463, 829.3448175940939, 934.2292608597934, 1006.1498034161123, 20672.79327206739, 21894.01476933542, 22603.095876165098, 22819.543609127726, 22960.851957402065, 883.9911600884037, 920.7110045935743, 945.0832692288469, 1003.7390278527636, 1042.4579218806177, 11124.33254004746, 11706.414679266003, 11858.466369013415, 12072.396380180955, 12147.210431321935, 605662.0, 615151.924240376, 632946.0, 634889.0, 637819.0, 78174.609126954, 108486.45756771165, 109794.0, 111984.96067676974, 121126.0, 941.8493041113389, 986.8914419413859, 1005.7284533176148, 1020.1940467031111, 1021.6066814276409, 15323.693526129193, 20018.299359522345, 20541.281055163, 20736.170553177704, 20805.271815486387, 54371.18443223434, 54529.45470545402, 54909.450905490434, 55716.16425753698, 56033.87932241414, 72213.638931805, 73451.26548734444, 74053.51892962218, 74282.0, 74961.62519187588, 6043.909341359971, 7917.960410198142, 8062.072861620754, 8116.391270654843, 8144.267015968354, 12701.682457938625, 12996.472627991578, 13315.334233288491, 13370.0, 13383.130096543693, 11200.38397888124, 11284.21010529255, 11599.246049006788, 11707.473163707824, 11744.647660570197, 7360.711875421673, 11302.208845380745, 11497.712557185803, 11693.473793679135, 11755.647330580096, 10216.511142716805, 11316.660500185008, 11401.087912966777, 11643.5342586299, 11858.229215100991, 6991.720331186899, 7979.805553472841, 8005.9599702001115, 8158.877616835871, 8235.711750088718, 9419.62321507132, 11239.426480292928, 11550.364729939934, 11598.826017609912, 11687.590934317259], "value": 9751.86423750952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.5411560069574, 1526.5267766992229, 1695.4489790817988, 1872.8969906655145, 1894.1476335648954, 8255.669773209072, 8779.0, 8790.516521591326, 8800.603972821222, 8818.955905220473, 7719.614019299027, 7967.123616402206, 8371.995360556743, 8570.357223208268, 8614.138586141382, 1920.9615807683838, 2337.5091230841545, 2339.87130707811, 2346.378209774411, 2346.7770561796688, 2098.3495116513927, 2185.8142057925015, 2326.4416540030356, 2352.0709319818748, 2355.7762012608773, 2317.687112239851, 2339.415146213447, 2350.576896158691, 2354.0348457132577, 2355.9882200588972, 2324.1052194904914, 2330.4057465346395, 2337.7077865266842, 2345.5074434368803, 2349.0, 2341.7775311345395, 2343.5781559319316, 2346.554154710617, 2349.635806450003, 2349.9412514687097, 8353.498790072554, 8515.829683406297, 8517.872231916526, 8518.659253629847, 8522.318214542822, 5115.565176959963, 5295.576353891679, 5295.576353891679, 5300.549453296474, 5302.575793936514, 3362.226687861781, 3414.7438942079443, 3552.9163605100694, 3554.893353199408, 3580.964190358089, 1047.2512153810062, 1078.8705355357329, 1086.8478413022183, 1105.5135740274254, 1108.7505311304972, 11355.716107097389, 11465.31208127515, 11472.31166130035, 11495.080393568494, 11509.94245028778, 4464.263396539534, 4604.079184163181, 4708.8116475341285, 4719.787609557578, 4725.740084295397, 9768.658096966572, 9773.706788796348, 9788.314817962817, 9794.118529332394, 9820.067093626094, 5238.397584277781, 5240.764165612557, 5248.976449592293, 5253.527182553588, 5265.420803711589, 3647.2705458908326, 4274.252005898955, 4403.889902752457, 4751.904961900743, 4811.206150985048, 3435.896923092311, 3810.2189051244427, 3914.8451206894033, 3932.2332145231403, 3962.0094976255937, 1140.9771804563861, 1230.446299165379, 1262.8042653388738, 1281.8525869524938, 1295.3717447038368, 800.2757504458474, 848.4273115646913, 856.7301300090452, 861.909684249425, 946.4888959961544, 4266.847951053261, 5492.176173573996, 5560.4161563036105, 5836.620619659709, 6028.90956635642, 944.2681921510884, 961.6393852305386, 963.9662611808693, 971.1017308989157, 1014.8680671512656, 3835.2329137047573, 3890.4747859038666, 3999.6600288975765, 4028.0, 4048.655864251513, 10088.092071713581, 10542.947285263677, 10544.89455105439, 10547.156227501935, 10548.578056877792, 9888.0, 10354.637587684394, 10487.685369438928, 10491.0, 10498.632547860789, 7665.9233407666325, 7874.960625196952, 7875.527468351803, 7880.566568838769, 7900.604969751489, 5699.259096317618, 5767.221425107557, 5795.884082318415, 5868.882622347443, 6129.632222066691, 9560.665376711782, 9830.901690983284, 9840.901590983998, 9849.704508864745, 9881.802363952824, 8682.34882383811, 9819.656312029045, 9833.0, 9936.056074672895, 9936.403815771077, 5197.66215196011, 6874.0, 7106.289371062852, 7391.8152046199275, 7538.924610754042, 7874.488158269694, 8165.918340816515, 8182.549959752271, 8184.345252379914, 8185.4270201085355, 7252.166000909963, 7333.449991250571, 7352.264773522605, 7394.667239974106, 7499.66251518672, 7228.20489746117, 7247.456440766858, 7255.746048888263, 7264.34620884123, 7306.963465182853, 6843.315668433117, 6851.828704282233, 6909.0, 6919.515633905578, 6928.203256625553, 4823.155947709207, 4882.780274887709, 4891.828785992473, 4920.8769780755765, 5012.774425150804, 4156.875293741193, 4789.353437286061, 4817.13291607514, 4881.975590122027, 4985.177445721561], "value": 4489.874456059837, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.29538473812278, 302.629279133062, 312.5170520216876, 318.647894077045, 319.4537341146639, 5166.896662066766, 5323.349761573915, 5383.703896285702, 5398.839249561343, 5401.353336864932, 4578.832397738572, 4585.403897493321, 4734.810607575701, 5046.470120637336, 5302.6213184572, 3543.4153364694794, 4090.1615168890307, 4091.2635725569385, 4100.949525237382, 4111.979440102796, 3351.782134161284, 3854.903627409309, 4108.506979162505, 4113.465249517559, 4136.73111247768, 4010.578889216634, 4014.0, 4027.41602467642, 4039.7172197946156, 4051.513818341803, 3995.9001024974464, 4012.819423125937, 4024.2756303865294, 4028.207447685781, 4036.979815100906, 2873.5976963224957, 3475.1138459692615, 3486.407310757152, 3498.352804731133, 3511.3328467591077, 4808.471068182497, 5209.557187639055, 5231.450697676727, 5248.580113590903, 5285.339332583427, 3935.429362742415, 4588.816447342102, 4596.563326483979, 4602.79287432063, 4603.83886563972, 4705.482566826731, 5617.399041273258, 5623.437656234385, 5626.493615574577, 5631.831045068655, 3236.9352612947846, 3351.581052368454, 3642.9271414571826, 3778.792166430845, 3817.4655548223272, 4988.5260900214425, 5861.710423706778, 5889.381614930457, 5890.263717035371, 5911.379305172981, 3340.9643010666773, 3801.3727734923427, 3886.70849686269, 3896.7467114638025, 3918.6277303656107, 2900.9854950725535, 3517.771344862576, 3776.4335349697217, 3902.5316961964177, 3916.8824935251987, 4525.275955847049, 4558.361829343895, 4558.9772051139535, 4568.474625418119, 4582.427196600425, 5610.97194514033, 5626.0, 5632.746526406239, 5647.576431767634, 5653.406392328829, 1055.8310670292717, 1097.2977294531506, 1174.9647510574696, 1297.4680381043727, 1312.7965165399378, 715.8246229673659, 749.2806905370796, 802.3340627279345, 821.8890449789321, 825.7729124490813, 4354.864497561751, 4369.825206991684, 4381.890452738707, 4384.956150438518, 4389.0, 4269.935950960676, 4467.235442000391, 4815.422149342101, 4826.300186472942, 4830.309391712873, 3560.857565697395, 4024.9798751006642, 4046.9595304046584, 4204.894877628022, 4391.365180891439, 2520.3069155982253, 2539.2225442190543, 2540.720520742717, 2542.694876614781, 2546.3761378462027, 4072.515765383114, 4223.366495025709, 4648.0, 4894.902101957941, 4987.950120498748, 4565.885852853705, 5012.724300163526, 5389.380221274525, 6011.969940150271, 6057.727402266909, 5274.841754747364, 6069.939300607026, 6110.930587147232, 6119.724612392542, 6132.540059495555, 5165.61257905651, 5256.868578285574, 5545.584081194007, 5824.592278540462, 5887.20522729426, 4902.264660300841, 5807.912881306699, 5819.621724587888, 5821.0, 5824.941905499647, 5235.712035838065, 5532.861678458071, 5607.43925607436, 6069.695015571673, 6074.453299203093, 3523.9119022024656, 3899.994553080251, 3967.484227050465, 4004.0, 4042.543625200529, 5624.484697064335, 5784.623999440023, 5793.449622286044, 5804.506616937439, 5808.82573522795, 4713.266305542708, 5339.572834173179, 5623.662580245198, 5629.831105066854, 5635.0, 4996.875078123076, 5509.029178763009, 5579.386267510489, 5618.578606604439, 5628.577856660685, 5273.338898247193, 5444.646098003617, 5468.699221542854, 5496.560275178056, 5505.752241149078, 5007.649464537593, 5137.8201762938115, 5448.809291674773, 5450.400455949922, 5702.830919661543, 5550.306211723535, 5554.2779438672715, 5556.305461817273, 5562.16567514876, 5570.3315602128005], "value": 3957.1307071528636, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.4786857725281, 727.261829243318, 752.8833030880209, 761.8209720715635, 876.163264082801, 14743.11541307521, 15877.841221587782, 16416.917915410435, 16436.0960147192, 16638.83361166388, 14480.275986200673, 14922.03006804557, 14924.850751492482, 14932.626684332898, 14948.103113813178, 679.4055201698513, 702.1679310017646, 870.1168314161147, 881.5988725130051, 884.5665623844302, 849.2399302624148, 879.3404946290283, 886.9822603547925, 887.4719541872576, 888.595688961521, 931.7437704631213, 933.1415098109721, 935.5135329628623, 936.6253498600546, 938.7746940734243, 713.201214639607, 749.8837680159584, 929.7117893453051, 930.6882194464862, 931.5668214280358, 602.8553147244629, 669.0900375489331, 684.2541629623685, 686.9175698916162, 688.0, 15112.168830714307, 15115.622109447242, 15157.090574565562, 15160.0, 15171.241437928169, 11426.714332141762, 14156.36296366666, 14246.216458094801, 14429.35067921946, 14465.421383144661, 10934.507947142318, 12938.741225175538, 12951.611451656465, 13221.206727596375, 13328.13367131143, 4531.889687026666, 4585.256651544264, 4650.604698600623, 4747.548982846624, 4748.3589715388325, 93642.0, 93683.0, 119061.0, 120299.0, 120320.99999999913, 10538.683839484827, 11002.0, 11299.152563557602, 11343.659690209306, 11363.261388009752, 22083.558328833333, 22176.1129554816, 22267.331980040624, 22271.44321391978, 22309.219177328716, 7918.326942209861, 8011.879821802678, 8087.878681819778, 8140.470869393471, 8197.508149511048, 3852.6339997700175, 4396.406485124531, 4424.690271680952, 4459.2865141577195, 4488.349189367524, 3411.334789716031, 3526.206603514189, 3558.7508874378545, 3565.893023209256, 3566.32239874423, 637.2512298049772, 639.8912184928573, 640.6220330005319, 660.5112216959416, 660.600336796241, 612.4640939178219, 613.1354789746437, 630.4357599948021, 646.1277275677797, 648.1703419622891, 8965.731028069038, 9052.818943621223, 9131.908680913106, 9133.269338452908, 9278.536073196314, 493.2207112761828, 539.1831375466094, 596.9910451343234, 599.8470390050509, 645.2128403347908, 3819.312523745697, 4468.709533880287, 4472.239719247736, 4474.709143905636, 4528.954710452853, 149928.0, 154655.0, 156521.0, 156961.4303856947, 161039.19480402523, 116664.0, 117939.41030294965, 121282.0, 135166.0, 142844.0, 80292.59853700694, 91557.0, 92345.0, 102335.0, 109984.4500777491, 9737.318387713076, 9955.153811925778, 9963.850542242017, 9993.750156245862, 10027.29808913369, 61249.08126378197, 63787.36212637814, 64439.67780161069, 65528.34471655222, 67248.66375668091, 77937.0, 90551.0, 94042.0, 97342.0, 98002.0, 12473.87526124727, 12973.0, 13109.672258193621, 13247.735045299232, 13317.933410333273, 14642.341094650554, 14692.265386730835, 14802.380131596645, 14812.925935370255, 14991.925040375165, 13776.862231377558, 13893.235872027135, 13985.510507132201, 14039.578812635229, 14370.568882933529, 11510.712232194262, 13659.248741319323, 13949.442022318994, 14167.504137355143, 14402.85597144015, 13408.798868017182, 13586.0, 13659.86340136586, 13674.863251367358, 13736.244506552235, 9225.358777789625, 10601.41692206936, 10749.635080282325, 11728.530858765895, 11973.16187866841, 9999.750006249902, 11418.657440276806, 11570.305781653127, 11624.186306958432, 11688.0], "value": 7864.11555043558, "unit": "score"}], "name": "dromaeo_css", "value": 7366.6512893827485, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 114.0, 116.0, 165.0, 150.0, 114.0, 112.0, 113.0], "value": 121.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 106.0, 166.0, 108.0, 107.0, 131.0, 105.0, 141.0, 106.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 186.0, 185.0, 183.0, 196.0, 237.0, 182.0, 183.0, 184.0], "value": 190.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 61.0, 89.0, 60.0, 58.0, 64.0, 63.0, 83.0, 57.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 99.0, 69.0, 77.0, 100.0, 130.0, 100.0, 67.0, 97.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 87.0, 84.0, 91.0, 83.0, 88.0, 83.0, 89.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 86.0, 87.0, 85.0, 84.0, 85.0, 85.0, 89.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 56.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 73.0, 67.0, 76.0, 73.0, 70.0, 71.0, 72.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 81.0, 85.0, 80.0, 85.0, 83.0, 84.0, 87.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 132.0, 148.0, 149.0, 134.0, 135.0, 140.0, 143.0, 151.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 169.0, 168.0, 168.0, 168.0, 160.0, 167.0, 166.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1439.2, "alertThreshold": 2.0}]} 06:12:55 INFO - Return code: 0 06:12:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:55 INFO - # TBPL SUCCESS # 06:12:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:55 INFO - 2016-08-08 06:12:55.801 screenresolution[1955:15253] starting screenresolution argv=screenresolution get 06:12:55 INFO - 2016-08-08 06:12:55.804 screenresolution[1955:15253] Display 0: 1600x1200x32@60 06:12:55 INFO - 2016-08-08 06:12:55.809 screenresolution[1956:15256] starting screenresolution argv=screenresolution list 06:12:55 INFO - Available Modes on Display 0 06:12:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:56 INFO - Intel Iris: 06:12:56 INFO - Chipset Model: Intel Iris 06:12:56 INFO - Type: GPU 06:12:56 INFO - Bus: Built-In 06:12:56 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:56 INFO - Vendor: Intel (0x8086) 06:12:56 INFO - Device ID: 0x0a2e 06:12:56 INFO - Revision ID: 0x0009 06:12:56 INFO - Displays: 06:12:56 INFO - Display: 06:12:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:56 INFO - Display Serial Number: 1600x1200 60 06:12:56 INFO - Main Display: Yes 06:12:56 INFO - Mirror: Off 06:12:56 INFO - Online: Yes 06:12:56 INFO - Rotation: Supported 06:12:56 INFO - Return code: 0 06:12:56 INFO - Running post-action listener: _resource_record_post_action 06:12:56 INFO - [mozharness: 2016-08-08 13:12:56.031017Z] Finished run-tests step (success) 06:12:56 INFO - Running post-run listener: _resource_record_post_run 06:12:56 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 1056768; Write bytes: 705230848; Read time: 13; Write time: 1968 06:12:56 INFO - TinderboxPrint: CPU usage
53.5% 06:12:56 INFO - TinderboxPrint: I/O read bytes / time
1,056,768 / 13 06:12:56 INFO - TinderboxPrint: I/O write bytes / time
705,230,848 / 1,968 06:12:56 INFO - TinderboxPrint: CPU idle
2,255.9 (46.5%) 06:12:56 INFO - TinderboxPrint: CPU system
975.1 (20.1%) 06:12:56 INFO - TinderboxPrint: CPU user
1,622.6 (33.4%) 06:12:56 INFO - TinderboxPrint: Swap in / out
408,596,480 / 0 06:12:56 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387813888; Write bytes: 384826880; Read time: 29023; Write time: 762 06:12:56 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 1056768; Write bytes: 292985344; Read time: 13; Write time: 1152 06:12:56 INFO - Running post-run listener: _upload_blobber_files 06:12:56 INFO - Blob upload gear active. 06:12:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:12:56 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:12:56 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:12:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:57 INFO - (blobuploader) - INFO - Done attempting. 06:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:58 INFO - (blobuploader) - INFO - Done attempting. 06:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:00 INFO - (blobuploader) - INFO - Done attempting. 06:13:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:00 INFO - Return code: 0 06:13:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ac4bf1642e099e7790c868091144342798e172ed9b78b8ce9cb4ba280b9c000362ddc2a494be2f760bad108a336a45f014e3a9d9fdc5be04433e9678ddf2c8d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/213e10b54fcc30290ebf3cd73f82411bc8a73f85ef31bf975c79ec4a725767e6f015b87f2de55680eedcbd10d731801146cd99b4f5a336317cdbf7cb058f3d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7c2c791df68aa64389c219a316d557f05902ec68eec4efae36f08fbb851e776e9cf657c18529c72c6b41a29a8d56ddaf4bfa16f5b54b8aeb72ba983563ed40c"} 06:13:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:00 INFO - Contents: 06:13:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ac4bf1642e099e7790c868091144342798e172ed9b78b8ce9cb4ba280b9c000362ddc2a494be2f760bad108a336a45f014e3a9d9fdc5be04433e9678ddf2c8d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/213e10b54fcc30290ebf3cd73f82411bc8a73f85ef31bf975c79ec4a725767e6f015b87f2de55680eedcbd10d731801146cd99b4f5a336317cdbf7cb058f3d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7c2c791df68aa64389c219a316d557f05902ec68eec4efae36f08fbb851e776e9cf657c18529c72c6b41a29a8d56ddaf4bfa16f5b54b8aeb72ba983563ed40c"} 06:13:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:00 INFO - Copying logs to upload dir... 06:13:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.408063 ========= master_lag: 1.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 06:13:01.816895) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:13:01.820025) ========= 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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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/Autoland/sha512/ac4bf1642e099e7790c868091144342798e172ed9b78b8ce9cb4ba280b9c000362ddc2a494be2f760bad108a336a45f014e3a9d9fdc5be04433e9678ddf2c8d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/213e10b54fcc30290ebf3cd73f82411bc8a73f85ef31bf975c79ec4a725767e6f015b87f2de55680eedcbd10d731801146cd99b4f5a336317cdbf7cb058f3d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7c2c791df68aa64389c219a316d557f05902ec68eec4efae36f08fbb851e776e9cf657c18529c72c6b41a29a8d56ddaf4bfa16f5b54b8aeb72ba983563ed40c"} build_url:https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/VHwSYtl-T2aUJRC1NaYBvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ac4bf1642e099e7790c868091144342798e172ed9b78b8ce9cb4ba280b9c000362ddc2a494be2f760bad108a336a45f014e3a9d9fdc5be04433e9678ddf2c8d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/213e10b54fcc30290ebf3cd73f82411bc8a73f85ef31bf975c79ec4a725767e6f015b87f2de55680eedcbd10d731801146cd99b4f5a336317cdbf7cb058f3d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7c2c791df68aa64389c219a316d557f05902ec68eec4efae36f08fbb851e776e9cf657c18529c72c6b41a29a8d56ddaf4bfa16f5b54b8aeb72ba983563ed40c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:13:01.859919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:13:01.860328) ========= 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.FXQe7bkLbS/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.DiuGXj4Bbh/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005175 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:13:01.909514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:13:01.909838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:13:01.910138) ========= ========= Total master_lag: 1.15 =========