builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0008 starttime: 1470764879.3 results: success (0) buildid: 20160809084020 builduid: 1e7d689181c84f68adafdfd3df5701c9 revision: d4b23db9ec3ac94a36e6bd09f15868b4b89e23c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.303020) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.303491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.303766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.331025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.331411) ========= 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.NZFsOpmchE/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.VT4VxugMsn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-09 10:47:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.0M=0.001s 2016-08-09 10:47:59 (15.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140790 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.495095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.495418) ========= 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.NZFsOpmchE/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.VT4VxugMsn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.027284 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 10:47:59.544827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 10:47:59.545170) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d4b23db9ec3ac94a36e6bd09f15868b4b89e23c9 --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 d4b23db9ec3ac94a36e6bd09f15868b4b89e23c9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NZFsOpmchE/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.VT4VxugMsn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-09 10:47:59,617 truncating revision to first 12 chars 2016-08-09 10:47:59,617 Setting DEBUG logging. 2016-08-09 10:47:59,617 attempt 1/10 2016-08-09 10:47:59,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d4b23db9ec3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 10:48:00,443 unpacking tar archive at: autoland-d4b23db9ec3a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.072369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 10:48:00.639376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 10:48:00.639695) ========= script_repo_revision: d4b23db9ec3ac94a36e6bd09f15868b4b89e23c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 10:48:00.640153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 10:48:00.640863) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 10:48:00.659201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-09 10:48:00.659646) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.NZFsOpmchE/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.VT4VxugMsn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:00 INFO - MultiFileLogger online at 20160809 10:48:00 in /builds/slave/test 10:48:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:48:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:48:00 INFO - {'append_to_log': False, 10:48:00 INFO - 'base_work_dir': '/builds/slave/test', 10:48:00 INFO - 'blob_upload_branch': 'Autoland', 10:48:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:48:00 INFO - 'branch': 'Autoland', 10:48:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:48:00 INFO - 'config_files': ('talos/mac_config.py',), 10:48:00 INFO - 'default_actions': ('clobber', 10:48:00 INFO - 'read-buildbot-config', 10:48:00 INFO - 'download-and-extract', 10:48:00 INFO - 'populate-webroot', 10:48:00 INFO - 'create-virtualenv', 10:48:00 INFO - 'install', 10:48:00 INFO - 'run-tests'), 10:48:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:48:00 INFO - 'download_minidump_stackwalk': True, 10:48:00 INFO - 'download_symbols': 'ondemand', 10:48:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:48:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:48:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:48:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:48:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:48:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:48:00 INFO - 'installer_path': 'installer.exe', 10:48:00 INFO - 'log_level': 'info', 10:48:00 INFO - 'log_name': 'talos', 10:48:00 INFO - 'log_to_console': True, 10:48:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:48:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:48:00 INFO - 'opt_config_files': (), 10:48:00 INFO - 'pip_index': False, 10:48:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:48:00 INFO - 'cmd': ('bash', 10:48:00 INFO - '-c', 10:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:48:00 INFO - 'enabled': True, 10:48:00 INFO - 'halt_on_failure': False, 10:48:00 INFO - 'name': 'check_screen_resolution'},), 10:48:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:48:00 INFO - 'cmd': ('bash', 10:48:00 INFO - '-c', 10:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:48:00 INFO - 'enabled': True, 10:48:00 INFO - 'halt_on_failure': False, 10:48:00 INFO - 'name': 'check_screen_resolution'},), 10:48:00 INFO - 'run_cmd_checks_enabled': True, 10:48:00 INFO - 'sps_profile': False, 10:48:00 INFO - 'sps_profile_interval': 0, 10:48:00 INFO - 'suite': 'dromaeojs-e10s', 10:48:00 INFO - 'system_bits': '32', 10:48:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:48:00 INFO - 'title': 't-yosemite-r7-0008', 10:48:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:48:00 INFO - 'use_talos_json': True, 10:48:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:48:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:48:00 INFO - 'work_dir': 'build'} 10:48:00 INFO - [mozharness: 2016-08-09 17:48:00.852070Z] Running clobber step. 10:48:00 INFO - Running pre-action listener: _resource_record_pre_action 10:48:00 INFO - Running main action method: clobber 10:48:00 INFO - rmtree: /builds/slave/test/build 10:48:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:48:03 INFO - Running post-action listener: _resource_record_post_action 10:48:03 INFO - [mozharness: 2016-08-09 17:48:03.001277Z] Finished clobber step (success) 10:48:03 INFO - [mozharness: 2016-08-09 17:48:03.001514Z] Running read-buildbot-config step. 10:48:03 INFO - Running pre-action listener: _resource_record_pre_action 10:48:03 INFO - Running main action method: read_buildbot_config 10:48:03 INFO - Using buildbot properties: 10:48:03 INFO - { 10:48:03 INFO - "project": "", 10:48:03 INFO - "product": "firefox", 10:48:03 INFO - "script_repo_revision": "production", 10:48:03 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 10:48:03 INFO - "repository": "", 10:48:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 10:48:03 INFO - "buildid": "20160809084020", 10:48:03 INFO - "pgo_build": "False", 10:48:03 INFO - "basedir": "/builds/slave/test", 10:48:03 INFO - "buildnumber": 125, 10:48:03 INFO - "slavename": "t-yosemite-r7-0008", 10:48:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:48:03 INFO - "platform": "yosemite_r7", 10:48:03 INFO - "scheduler": "tests-autoland-macosx64-talos", 10:48:03 INFO - "branch": "autoland", 10:48:03 INFO - "repo_path": "integration/autoland", 10:48:03 INFO - "revision": "d4b23db9ec3ac94a36e6bd09f15868b4b89e23c9", 10:48:03 INFO - "stage_platform": "macosx64", 10:48:03 INFO - "builduid": "1e7d689181c84f68adafdfd3df5701c9", 10:48:03 INFO - "slavebuilddir": "test" 10:48:03 INFO - } 10:48:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:48:03 INFO - Running post-action listener: _resource_record_post_action 10:48:03 INFO - [mozharness: 2016-08-09 17:48:03.007138Z] Finished read-buildbot-config step (success) 10:48:03 INFO - [mozharness: 2016-08-09 17:48:03.007417Z] Running download-and-extract step. 10:48:03 INFO - Running pre-action listener: _resource_record_pre_action 10:48:03 INFO - Running main action method: download_and_extract 10:48:03 INFO - mkdir: /builds/slave/test/build/tests 10:48:03 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')]} 10:48:03 INFO - trying https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:48:03 INFO - Downloading https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:04 INFO - Downloaded 1199 bytes. 10:48:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:48:04 INFO - Using the following test package requirements: 10:48:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:48:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:48:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:48:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'jsshell-mac.zip'], 10:48:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:48:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:48:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:48:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:48:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:48:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:48:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:48:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:04 INFO - trying https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:48:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:05 INFO - Downloaded 16326432 bytes. 10:48:05 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'] 10:48:05 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 10:48:08 INFO - Return code: 0 10:48:08 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 10:48: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')]} 10:48:08 INFO - trying https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:48:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:09 INFO - Downloaded 16326432 bytes. 10:48:09 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'] 10:48:09 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 10:48:12 INFO - Return code: 0 10:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:12 INFO - trying https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:48:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:13 INFO - Downloaded 14413723 bytes. 10:48:13 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'] 10:48:13 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 10:48:14 INFO - Return code: 0 10:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:14 INFO - trying https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:48:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:48:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/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 10:48:16 INFO - Downloaded 110903937 bytes. 10:48:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:48:16 INFO - mkdir: /builds/slave/test/properties 10:48:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:48:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:48:16 INFO - Contents: 10:48:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:48:17 INFO - Running post-action listener: _resource_record_post_action 10:48:17 INFO - Running post-action listener: set_extra_try_arguments 10:48:17 INFO - [mozharness: 2016-08-09 17:48:17.946655Z] Finished download-and-extract step (success) 10:48:17 INFO - [mozharness: 2016-08-09 17:48:17.946796Z] Running populate-webroot step. 10:48:17 INFO - Running pre-action listener: _resource_record_pre_action 10:48:17 INFO - Running main action method: populate_webroot 10:48:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:48:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:48:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:48:17 INFO - '--tppagecycles', 10:48:17 INFO - '7'], 10:48:17 INFO - 'tests': ['tsvgm']}}, 10:48:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:48:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:48:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:48:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:48:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['damp', 'tps']}, 10:48:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'tests': ['damp', 'tps']}, 10:48:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['dromaeo_dom']}, 10:48:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:48:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['basic_compositor_video']}, 10:48:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:48:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['a11yr', 10:48:17 INFO - 'ts_paint', 10:48:17 INFO - 'tpaint', 10:48:17 INFO - 'sessionrestore', 10:48:17 INFO - 'sessionrestore_no_auto_restore', 10:48:17 INFO - 'tabpaint']}, 10:48:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:48:17 INFO - 'ts_paint', 10:48:17 INFO - 'tpaint', 10:48:17 INFO - 'sessionrestore', 10:48:17 INFO - 'sessionrestore_no_auto_restore', 10:48:17 INFO - 'tabpaint']}, 10:48:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:48:17 INFO - 'ts_paint', 10:48:17 INFO - 'tpaint', 10:48:17 INFO - 'sessionrestore', 10:48:17 INFO - 'sessionrestore_no_auto_restore', 10:48:17 INFO - 'tabpaint']}, 10:48:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:48:17 INFO - 'ts_paint', 10:48:17 INFO - 'tpaint', 10:48:17 INFO - 'sessionrestore', 10:48:17 INFO - 'sessionrestore_no_auto_restore', 10:48:17 INFO - 'tabpaint']}, 10:48:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['a11yr', 10:48:17 INFO - 'ts_paint', 10:48:17 INFO - 'tpaint', 10:48:17 INFO - 'sessionrestore', 10:48:17 INFO - 'sessionrestore_no_auto_restore', 10:48:17 INFO - 'tabpaint']}, 10:48:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['a11yr', 10:48:17 INFO - 'ts_paint', 10:48:17 INFO - 'tpaint', 10:48:17 INFO - 'sessionrestore', 10:48:17 INFO - 'sessionrestore_no_auto_restore', 10:48:17 INFO - 'tabpaint']}, 10:48:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['tsvgx', 10:48:17 INFO - 'tsvgr_opacity', 10:48:17 INFO - 'tart', 10:48:17 INFO - 'tscrollx', 10:48:17 INFO - 'cart']}, 10:48:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:48:17 INFO - 'tsvgr_opacity', 10:48:17 INFO - 'tart', 10:48:17 INFO - 'tscrollx', 10:48:17 INFO - 'cart']}, 10:48:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'talos_options': ['--disable-e10s'], 10:48:17 INFO - 'tests': ['tp5o']}, 10:48:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'tests': ['tp5o']}, 10:48:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'talos_options': ['--disable-e10s', 10:48:17 INFO - '--xperf_path', 10:48:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:17 INFO - 'tests': ['tp5n']}, 10:48:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:17 INFO - 'talos_options': ['--xperf_path', 10:48:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:17 INFO - 'tests': ['tp5n']}}, 10:48:17 INFO - 'talos.zip': {'path': '', 10:48:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:48:17 INFO - Running post-action listener: _resource_record_post_action 10:48:17 INFO - [mozharness: 2016-08-09 17:48:17.965488Z] Finished populate-webroot step (success) 10:48:17 INFO - [mozharness: 2016-08-09 17:48:17.965595Z] Running create-virtualenv step. 10:48:17 INFO - Running pre-action listener: _resource_record_pre_action 10:48:17 INFO - Running main action method: create_virtualenv 10:48:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:48:17 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 10:48:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:48:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:48:18 INFO - Using real prefix '/tools/python27' 10:48:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:48:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:48:21 INFO - Installing pip.................done. 10:48:21 INFO - Return code: 0 10:48:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:48:21 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')]} 10:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:21 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')]} 10:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:21 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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:21 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 10:48:21 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 10:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:21 INFO - 'HOME': '/Users/cltbld', 10:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:21 INFO - 'LOGNAME': 'cltbld', 10:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:21 INFO - 'MOZ_NO_REMOTE': '1', 10:48:21 INFO - 'NO_EM_RESTART': '1', 10:48:21 INFO - 'PAGER': '/bin/cat', 10:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:21 INFO - 'PWD': '/builds/slave/test', 10:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:21 INFO - 'SHELL': '/bin/bash', 10:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:21 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:21 INFO - 'USER': 'cltbld', 10:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:21 INFO - 'XPC_FLAGS': '0x0', 10:48:21 INFO - 'XPC_SERVICE_NAME': '0', 10:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:21 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 10:48:21 INFO - Cleaning up... 10:48:21 INFO - Return code: 0 10:48:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:48:21 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')]} 10:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:21 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')]} 10:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:21 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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:21 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 10:48:21 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 10:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:21 INFO - 'HOME': '/Users/cltbld', 10:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:21 INFO - 'LOGNAME': 'cltbld', 10:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:21 INFO - 'MOZ_NO_REMOTE': '1', 10:48:21 INFO - 'NO_EM_RESTART': '1', 10:48:21 INFO - 'PAGER': '/bin/cat', 10:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:21 INFO - 'PWD': '/builds/slave/test', 10:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:21 INFO - 'SHELL': '/bin/bash', 10:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:21 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:21 INFO - 'USER': 'cltbld', 10:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:21 INFO - 'XPC_FLAGS': '0x0', 10:48:21 INFO - 'XPC_SERVICE_NAME': '0', 10:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:22 INFO - Downloading/unpacking psutil>=3.1.1 10:48:22 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 10:48:22 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 10:48:22 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 10:48:22 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 10:48:22 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 10:48:22 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 10:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:25 INFO - Installing collected packages: psutil 10:48:25 INFO - Running setup.py install for psutil 10:48:25 INFO - building 'psutil._psutil_osx' extension 10:48:25 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 10:48:26 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 10:48:26 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 10:48:26 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 10:48:26 INFO - building 'psutil._psutil_posix' extension 10:48:26 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 10:48:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:48:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:48:26 INFO - ^ 10:48:26 INFO - 1 warning generated. 10:48:26 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 10:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:26 INFO - Successfully installed psutil 10:48:26 INFO - Cleaning up... 10:48:26 INFO - Return code: 0 10:48:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:48: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')]} 10:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:48: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 mozsystemmonitor==0.3 10:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:26 INFO - 'HOME': '/Users/cltbld', 10:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:26 INFO - 'LOGNAME': 'cltbld', 10:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:26 INFO - 'MOZ_NO_REMOTE': '1', 10:48:26 INFO - 'NO_EM_RESTART': '1', 10:48:26 INFO - 'PAGER': '/bin/cat', 10:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:26 INFO - 'PWD': '/builds/slave/test', 10:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:26 INFO - 'SHELL': '/bin/bash', 10:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:26 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:26 INFO - 'USER': 'cltbld', 10:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:26 INFO - 'XPC_FLAGS': '0x0', 10:48:26 INFO - 'XPC_SERVICE_NAME': '0', 10:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:48:29 INFO - Installing collected packages: mozsystemmonitor 10:48:29 INFO - Running setup.py install for mozsystemmonitor 10:48:29 INFO - Successfully installed mozsystemmonitor 10:48:29 INFO - Cleaning up... 10:48:29 INFO - Return code: 0 10:48:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:29 INFO - 'HOME': '/Users/cltbld', 10:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:29 INFO - 'LOGNAME': 'cltbld', 10:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:29 INFO - 'MOZ_NO_REMOTE': '1', 10:48:29 INFO - 'NO_EM_RESTART': '1', 10:48:29 INFO - 'PAGER': '/bin/cat', 10:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:29 INFO - 'PWD': '/builds/slave/test', 10:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:29 INFO - 'SHELL': '/bin/bash', 10:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:29 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:29 INFO - 'USER': 'cltbld', 10:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:29 INFO - 'XPC_FLAGS': '0x0', 10:48:29 INFO - 'XPC_SERVICE_NAME': '0', 10:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:30 INFO - Downloading/unpacking jsonschema==2.5.1 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:48:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:32 INFO - Downloading functools32-3.2.3-2.tar.gz 10:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:48:32 INFO - warning: no files found matching '*.txt' 10:48:32 INFO - no previously-included directories found matching 'build' 10:48:32 INFO - no previously-included directories found matching 'dist' 10:48:32 INFO - no previously-included directories found matching '.git*' 10:48:32 INFO - Installing collected packages: jsonschema, functools32 10:48:33 INFO - Running setup.py install for functools32 10:48:33 INFO - warning: no files found matching '*.txt' 10:48:33 INFO - no previously-included directories found matching 'build' 10:48:33 INFO - no previously-included directories found matching 'dist' 10:48:33 INFO - no previously-included directories found matching '.git*' 10:48:33 INFO - Successfully installed jsonschema functools32 10:48:33 INFO - Cleaning up... 10:48:33 INFO - Return code: 0 10:48:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:33 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 10:48:33 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 10:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:33 INFO - 'HOME': '/Users/cltbld', 10:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:33 INFO - 'LOGNAME': 'cltbld', 10:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:33 INFO - 'MOZ_NO_REMOTE': '1', 10:48:33 INFO - 'NO_EM_RESTART': '1', 10:48:33 INFO - 'PAGER': '/bin/cat', 10:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:33 INFO - 'PWD': '/builds/slave/test', 10:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:33 INFO - 'SHELL': '/bin/bash', 10:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:33 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:33 INFO - 'USER': 'cltbld', 10:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:33 INFO - 'XPC_FLAGS': '0x0', 10:48:33 INFO - 'XPC_SERVICE_NAME': '0', 10:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:48:33 INFO - Cleaning up... 10:48:33 INFO - Return code: 0 10:48:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:33 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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:33 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 10:48:33 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 10:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:33 INFO - 'HOME': '/Users/cltbld', 10:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:33 INFO - 'LOGNAME': 'cltbld', 10:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:33 INFO - 'MOZ_NO_REMOTE': '1', 10:48:33 INFO - 'NO_EM_RESTART': '1', 10:48:33 INFO - 'PAGER': '/bin/cat', 10:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:33 INFO - 'PWD': '/builds/slave/test', 10:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:33 INFO - 'SHELL': '/bin/bash', 10:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:33 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:33 INFO - 'USER': 'cltbld', 10:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:33 INFO - 'XPC_FLAGS': '0x0', 10:48:33 INFO - 'XPC_SERVICE_NAME': '0', 10:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:48:33 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 10:48:33 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 10:48:33 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 10:48:33 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 10:48:33 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 10:48:33 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 10:48:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:48:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:48:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:48:37 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 10:48:37 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 10:48:37 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 10:48:37 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 10:48:37 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 10:48:37 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 10:48:37 INFO - Downloading docopt-0.6.1.tar.gz 10:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:48:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:48:37 INFO - Running setup.py install for blobuploader 10:48:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:48:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:48:37 INFO - Running setup.py install for requests 10:48:38 INFO - Running setup.py install for docopt 10:48:38 INFO - Successfully installed blobuploader requests docopt 10:48:38 INFO - Cleaning up... 10:48:38 INFO - Return code: 0 10:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:38 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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:38 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 10:48:38 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 10:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:38 INFO - 'HOME': '/Users/cltbld', 10:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:38 INFO - 'LOGNAME': 'cltbld', 10:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:38 INFO - 'MOZ_NO_REMOTE': '1', 10:48:38 INFO - 'NO_EM_RESTART': '1', 10:48:38 INFO - 'PAGER': '/bin/cat', 10:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:38 INFO - 'PWD': '/builds/slave/test', 10:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:38 INFO - 'SHELL': '/bin/bash', 10:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:38 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:38 INFO - 'USER': 'cltbld', 10:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:38 INFO - 'XPC_FLAGS': '0x0', 10:48:38 INFO - 'XPC_SERVICE_NAME': '0', 10:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:48:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-5r_DWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:48:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-859zA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:48:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-qt_n0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:48:38 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wd2g_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-B7zkSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-HJeboY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-pWogmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-TP7twY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-r5WG64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-iXFaSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-rIG3xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-w5kuNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-DTfIjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:48:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-EOWWVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-HKXzXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:48:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ow9JAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:48:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wuLL8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:48:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:48:40 INFO - Running setup.py install for manifestparser 10:48:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:48:40 INFO - Running setup.py install for mozcrash 10:48:40 INFO - Running setup.py install for mozdebug 10:48:40 INFO - Running setup.py install for mozdevice 10:48:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:48:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:48:40 INFO - Running setup.py install for mozfile 10:48:41 INFO - Running setup.py install for mozhttpd 10:48:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:48:41 INFO - Running setup.py install for mozinfo 10:48:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:48:41 INFO - Running setup.py install for mozInstall 10:48:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:48:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:48:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:48:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:48:41 INFO - Running setup.py install for mozleak 10:48:41 INFO - Running setup.py install for mozlog 10:48:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:48:41 INFO - Running setup.py install for moznetwork 10:48:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:48:42 INFO - Running setup.py install for mozprocess 10:48:42 INFO - Running setup.py install for mozprofile 10:48:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:48:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:48:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:48:42 INFO - Running setup.py install for mozrunner 10:48:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:48:42 INFO - Running setup.py install for mozscreenshot 10:48:42 INFO - Running setup.py install for moztest 10:48:42 INFO - Running setup.py install for mozversion 10:48:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:48:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:48:42 INFO - Cleaning up... 10:48:42 INFO - Return code: 0 10:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48: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')]} 10:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:42 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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:42 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 10:48:42 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 10:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:42 INFO - 'HOME': '/Users/cltbld', 10:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:42 INFO - 'LOGNAME': 'cltbld', 10:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:42 INFO - 'MOZ_NO_REMOTE': '1', 10:48:42 INFO - 'NO_EM_RESTART': '1', 10:48:42 INFO - 'PAGER': '/bin/cat', 10:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:42 INFO - 'PWD': '/builds/slave/test', 10:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:42 INFO - 'SHELL': '/bin/bash', 10:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:42 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:42 INFO - 'USER': 'cltbld', 10:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:42 INFO - 'XPC_FLAGS': '0x0', 10:48:42 INFO - 'XPC_SERVICE_NAME': '0', 10:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-NYXHkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:48:43 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)) 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-MmTXBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:48:43 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)) 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CiMrh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:48:43 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)) 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-gR6BHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:48:43 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)) 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-1PxFkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:48:43 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)) 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Gx_ERN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:48:43 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)) 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-vadJ4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:48:43 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)) 10:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:48:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-sEL1bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wQuDYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-PG0t_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-i7xA8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-rIJ8fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zPVl9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-mkiWzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-1rCIyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-YNVzP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:48:44 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)) 10:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:48:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Y5JlIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:48:45 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)) 10:48:45 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)) 10:48:45 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)) 10:48:45 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)) 10:48:45 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)) 10:48:45 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)) 10:48:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:48:45 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 10:48:45 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 10:48:45 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 10:48:45 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 10:48:45 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 10:48:45 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 10:48:47 INFO - Downloading blessings-1.6.tar.gz 10:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:48:47 INFO - Installing collected packages: blessings 10:48:47 INFO - Running setup.py install for blessings 10:48:47 INFO - Successfully installed blessings 10:48:47 INFO - Cleaning up... 10:48:47 INFO - Return code: 0 10:48:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:48:48 INFO - Reading from file tmpfile_stdout 10:48:48 INFO - Current package versions: 10:48:48 INFO - blessings == 1.6 10:48:48 INFO - blobuploader == 1.2.4 10:48:48 INFO - docopt == 0.6.1 10:48:48 INFO - functools32 == 3.2.3-2 10:48:48 INFO - jsonschema == 2.5.1 10:48:48 INFO - manifestparser == 1.1 10:48:48 INFO - mozInstall == 1.12 10:48:48 INFO - mozcrash == 0.17 10:48:48 INFO - mozdebug == 0.1 10:48:48 INFO - mozdevice == 0.48 10:48:48 INFO - mozfile == 1.2 10:48:48 INFO - mozhttpd == 0.7 10:48:48 INFO - mozinfo == 0.9 10:48:48 INFO - mozleak == 0.1 10:48:48 INFO - mozlog == 3.3 10:48:48 INFO - moznetwork == 0.27 10:48:48 INFO - mozprocess == 0.23 10:48:48 INFO - mozprofile == 0.28 10:48:48 INFO - mozrunner == 6.12 10:48:48 INFO - mozscreenshot == 0.1 10:48:48 INFO - mozsystemmonitor == 0.3 10:48:48 INFO - moztest == 0.7 10:48:48 INFO - mozversion == 1.4 10:48:48 INFO - psutil == 3.1.1 10:48:48 INFO - requests == 1.2.3 10:48:48 INFO - wsgiref == 0.1.2 10:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:48 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 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:48 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 10:48:48 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 10:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:48 INFO - 'HOME': '/Users/cltbld', 10:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:48 INFO - 'LOGNAME': 'cltbld', 10:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:48 INFO - 'MOZ_NO_REMOTE': '1', 10:48:48 INFO - 'NO_EM_RESTART': '1', 10:48:48 INFO - 'PAGER': '/bin/cat', 10:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:48 INFO - 'PWD': '/builds/slave/test', 10:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:48 INFO - 'SHELL': '/bin/bash', 10:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:48 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:48 INFO - 'USER': 'cltbld', 10:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:48 INFO - 'XPC_FLAGS': '0x0', 10:48:48 INFO - 'XPC_SERVICE_NAME': '0', 10:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 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)) 10:48:48 INFO - Cleaning up... 10:48:48 INFO - Return code: 0 10:48:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b02ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0c3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f958acd9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, '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.NZFsOpmchE/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.VT4VxugMsn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 10:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:48:48 INFO - 'HOME': '/Users/cltbld', 10:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:48:48 INFO - 'LOGNAME': 'cltbld', 10:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:48 INFO - 'MOZ_NO_REMOTE': '1', 10:48:48 INFO - 'NO_EM_RESTART': '1', 10:48:48 INFO - 'PAGER': '/bin/cat', 10:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:48 INFO - 'PWD': '/builds/slave/test', 10:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:48:48 INFO - 'SHELL': '/bin/bash', 10:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:48:48 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:48:48 INFO - 'USER': 'cltbld', 10:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:48 INFO - 'XPC_FLAGS': '0x0', 10:48:48 INFO - 'XPC_SERVICE_NAME': '0', 10:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:48:48 INFO - Cleaning up... 10:48:48 INFO - Return code: 0 10:48:48 INFO - Running post-action listener: _resource_record_post_action 10:48:48 INFO - Running post-action listener: _start_resource_monitoring 10:48:48 INFO - Starting resource monitoring. 10:48:48 INFO - [mozharness: 2016-08-09 17:48:48.746232Z] Finished create-virtualenv step (success) 10:48:48 INFO - [mozharness: 2016-08-09 17:48:48.747177Z] Running install step. 10:48:48 INFO - Running pre-action listener: _resource_record_pre_action 10:48:48 INFO - Running main action method: install 10:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:48:49 INFO - Reading from file tmpfile_stdout 10:48:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:48:49 INFO - Reading from file tmpfile_stdout 10:48:49 INFO - Output received: 10:48:49 INFO - Usage: mozinstall [options] installer 10:48:49 INFO - Options: 10:48:49 INFO - -h, --help show this help message and exit 10:48:49 INFO - -d DEST, --destination=DEST 10:48:49 INFO - Directory to install application into. [default: 10:48:49 INFO - "/builds/slave/test"] 10:48:49 INFO - --app=APP Application being installed. [default: firefox] 10:48:49 INFO - mkdir: /builds/slave/test/build/application 10:48:49 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'] 10:48:49 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 10:49:22 INFO - Reading from file tmpfile_stdout 10:49:22 INFO - Output received: 10:49:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:49:22 INFO - Running post-action listener: _resource_record_post_action 10:49:22 INFO - [mozharness: 2016-08-09 17:49:22.730597Z] Finished install step (success) 10:49:22 INFO - [mozharness: 2016-08-09 17:49:22.730709Z] Running run-tests step. 10:49:22 INFO - Running pre-action listener: _resource_record_pre_action 10:49:22 INFO - Running main action method: run_tests 10:49:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:49:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:49:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:49:22 INFO - 2016-08-09 10:49:22.745 screenresolution[1642:7543] starting screenresolution argv=screenresolution get 10:49:22 INFO - 2016-08-09 10:49:22.748 screenresolution[1642:7543] Display 0: 1600x1200x32@60 10:49:22 INFO - 2016-08-09 10:49:22.754 screenresolution[1643:7545] starting screenresolution argv=screenresolution list 10:49:22 INFO - Available Modes on Display 0 10:49:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:49:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:49:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:49:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:49:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:49:22 INFO - Intel Iris: 10:49:22 INFO - Chipset Model: Intel Iris 10:49:22 INFO - Type: GPU 10:49:22 INFO - Bus: Built-In 10:49:22 INFO - VRAM (Dynamic, Max): 1536 MB 10:49:22 INFO - Vendor: Intel (0x8086) 10:49:22 INFO - Device ID: 0x0a2e 10:49:22 INFO - Revision ID: 0x0009 10:49:22 INFO - Displays: 10:49:22 INFO - Display: 10:49:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:49:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:49:22 INFO - Display Serial Number: 1600x1200 60 10:49:22 INFO - Main Display: Yes 10:49:22 INFO - Mirror: Off 10:49:22 INFO - Online: Yes 10:49:22 INFO - Rotation: Supported 10:49:22 INFO - Return code: 0 10:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:49:22 INFO - Python 2.7.3 10:49:22 INFO - Return code: 0 10:49:22 INFO - grabbing minidump binary from tooltool 10:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:22 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 0x10af92d30>, '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 0x10acf7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af8ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:49:22 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 10:49:22 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 10:49:22 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 10:49:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:49:23 INFO - Return code: 0 10:49:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:49:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:49:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:49:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:49:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:49:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NZFsOpmchE/Render', 10:49:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:49:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:49:23 INFO - 'HOME': '/Users/cltbld', 10:49:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:49:23 INFO - 'LOGNAME': 'cltbld', 10:49:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:49:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:23 INFO - 'MOZ_NO_REMOTE': '1', 10:49:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:49:23 INFO - 'NO_EM_RESTART': '1', 10:49:23 INFO - 'PAGER': '/bin/cat', 10:49:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:23 INFO - 'PWD': '/builds/slave/test', 10:49:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:49:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:49:23 INFO - 'SHELL': '/bin/bash', 10:49:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VT4VxugMsn/Listeners', 10:49:23 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:49:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:49:23 INFO - 'USER': 'cltbld', 10:49:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:49:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:23 INFO - 'XPC_FLAGS': '0x0', 10:49:23 INFO - 'XPC_SERVICE_NAME': '0', 10:49:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:49:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:49:23 INFO - mozversion application_buildid: 20160809084020 10:49:23 INFO - mozversion application_changeset: d4b23db9ec3ac94a36e6bd09f15868b4b89e23c9 10:49:23 INFO - mozversion application_display_name: Nightly 10:49:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:49:23 INFO - mozversion application_name: Firefox 10:49:23 INFO - mozversion application_remotingname: firefox 10:49:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:49:23 INFO - mozversion application_vendor: Mozilla 10:49:23 INFO - mozversion application_version: 51.0a1 10:49:23 INFO - mozversion platform_buildid: 20160809084020 10:49:23 INFO - mozversion platform_changeset: d4b23db9ec3ac94a36e6bd09f15868b4b89e23c9 10:49:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:49:23 INFO - mozversion platform_version: 51.0a1 10:49:23 INFO - using testdate: 1470764963 10:49:23 INFO - actual date: 1470764963 10:49:23 INFO - starting webserver on 'localhost:49271' 10:49:23 INFO - SUITE-START | Running 2 tests 10:49:23 INFO - TEST-START | dromaeo_css 10:49:23 INFO - operating with platform_type : mac_ 10:49:23 INFO - Initialising browser for dromaeo_css test... 10:49:23 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpAkhAWm/profile http://localhost:49271/getInfo.html) 10:49:26 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 10:49:26 INFO - PROCESS | 1653 | colorDepth:24 10:49:26 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 10:49:26 INFO - PROCESS | 1653 | __metrics 10:49:26 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:49:27 INFO - TEST-INFO | 1653: exit 0 10:49:27 INFO - Browser initialized. 10:49:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:49:27 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpAkhAWm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:39 INFO - PROCESS | 1656 | RSS: Main: 254480384 10:49:39 INFO - PROCESS | 1656 | 10:50:28 INFO - PROCESS | 1656 | 1470765028737 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] 10:52:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 10:52:56 INFO - PROCESS | 1656 | RSS: Main: 266936320 10:52:56 INFO - PROCESS | 1656 | 10:55:58 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 10:55:59 INFO - PROCESS | 1656 | RSS: Main: 281190400 10:55:59 INFO - PROCESS | 1656 | 10:59:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 10:59:01 INFO - PROCESS | 1656 | RSS: Main: 285237248 10:59:01 INFO - PROCESS | 1656 | 11:02:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 11:02:04 INFO - PROCESS | 1656 | RSS: Main: 287371264 11:02:04 INFO - PROCESS | 1656 | 11:05:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 11:05:07 INFO - PROCESS | 1656 | RSS: Main: 290893824 11:05:07 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 11:08:10 INFO - PROCESS | 1656 | RSS: Main: 291672064 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | __start_tp_report 11:08:10 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 11:08:10 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 11:08:10 INFO - PROCESS | 1656 | |i|pagename|runs| 11:08:10 INFO - PROCESS | 1656 | |0;dojo.html;3416.333814906094;3427.3316703242867;3455.378031954247;3465.116395319194;3470.8264586770656;760.0977268505952;936.8963937951762;1030.5122078330735;1519.597306713719;5710.800121995726;897.5027953783078;979.9959083673887;1013.0913704607922;1025.9020303479383;1029.675652169568;857.837630011332;870.3689824876946;938.2579773714258;957.9473128977938;1037.6251019717859;751.9360854327389;819.0860672681712;997.8435600862605;5233.058049551079;5286.286351342558;4157.043879907608;5124.641275110744;5202.271681964528;5272.103742363807;5313.654612450178;5255.159174532057;5301;5337.279467271907;5346.839594812123;5349.839504814861;5065.594752419797;5263.684178949237;5274.604404669665;5284.154535274338;5296.523312901857;5672.035753921843;5759.452851979056;5784.855378615526;5799.5070419014855;5800.8259752207505;6190.597611155261;6193.876122477525;6215.34738852414;6220.7511699532415;6222.688865556704;6154.784582539679;6223.533235007392;6259.96870015647;6264.812055638338;6302.833975714508;4780.760961951889;5907.172995780594;5916.319623243296;5924.526037916957;5970.0746384310505;6312.179416675803;6316.463100636405;6333.68331583419;6353.396427339396;6366.745330186741;6070.939290607126;6142.1266513713745;6142.3759981611065;6204.875902481925;6225.719842607094;6204.441600255998;6205.317415084427;6221.06683997404;6230.7507699691505;6235.407636274546;6178.876422471615;6183.103449999725;6185.690715464209;6190.380961903864;6207.6275423474735;6051.546134039964;6090.33006369299;6109.358517355614;6123.435141503484;6142.385761423911;4990.8752281193265;5020.824271150492;5035.1188542005;5054.7978080876355;5073.340465739504;4482.731036137842;4510.188166130062;4511.864644060618;4515.751633660115;4527.3435351873795;5628.409017053233;5762;5773.595848290579;5855.443732845458;5872.265966754156;6168.845778855475;6191.4118158774845;6198.597091189148;6199.3490683478485;6209.96895015531;5848.2689663792025;5882.911756323573;5882.911756323573;5912.615679980788;5914.763409463573;5372;5416.431274716098;5448.182772584144;5485.424030476743;5511.393746687781;6346.524010699124;6352.714127864165;6360.204974378203;6375.203099612549;6379.936200637934;6021.969890150521;6131.080337949344;6167.938320616737;6171.259448866164;6172.22847144107;4875.609951203966;6107.401224262618;6129.969350153221;6326.525510586633;6350.460210882126;6158.107074474086;6193.194884664965;6194.349593292639;6207.534434917309;6209.975354066529;5948.672822994777;6058.182145410489;6173.629582225081;6198.783042593487;6209.0996805462055;4948.505149485023;6020;6102.633841969496;6177.320494745664;6193.81418557444;6088.822718060938;6114.054067497291;6141.385861413823;6152.046432802923;6167.784127555514;6001.7299221536005;6030.638161710312;6041.18444010053;6047.425494578008;6091.9086213707715;6057.454829065406;6109.877802444015;6133.080037994337;6156.876862462636;6178.876422471435;6035.124906888389;6059;6061.272647282178;6117.694115294128;6126.663033533198 11:08:10 INFO - PROCESS | 1656 | |1;ext.html;479.79608666316807;497.3832447764773;509.74512743628185;521.2780299285488;525.6097621790364;32793.50809737856;39336;42290.15419691608;42533.78733106334;42611;35152;43425;43529;43597.564024359745;43735.78132109343;9632.47021413822;9818.90181098187;9839.114479696862;9846.212303015742;9846.55690493926;9790.755231119243;9880.505974701273;9892.060254275832;9893.4558599277;9899.901000990007;9922.255830812683;9963.501824908763;9984.700458986243;10004.099631033205;10004.199664026897;9863.408195508257;9942.90057099427;9943.105120539187;9943.105120539187;9946.303758736927;9830.410175389428;9899.851502227473;9926.255530835217;9937.503124843728;9946.452945088018;40498;40835.38746918798;41165.176696465904;41183.38224926629;41350.37974430386;3386;3489.45913383426;3498.7375946803836;3583.4087375583;3901.9804900975596;32625.836870815732;32962.83518582416;33412.33175336479;33737.49393759095;33846.6615333846;3244.1889527618096;3310.4206763816237;3325.218573635194;3382.543356646846;3411.7441191910707;389518;396949;398523;398789;399259;57158.42841571531;57505;57516.42483575195;57529.137062944086;57576.42423575794;35461.290774184374;36301.636983629825;36330.45504317437;37245.813770930974;37350;16699.332026718796;16880.409185678443;16920.40778572744;16927.238274277686;16927.984320940785;12295.754084918251;12610.81083783744;12671.556495522613;12777.425015874307;12798.808017879739;16401.42595009169;17269.740953885703;20306.796932030786;20322.67902586327;20375.592488150152;6476.6114033158165;8098.919010809935;8131.15409606633;8183.79540511492;8222.342212623096;936.391345625349;986.7779749556292;996.8704068471052;1040.7086015915556;1070.7590792071721;26861.462770744474;29839.85080074586;30587.541186882216;31143.547482845937;31352.37295254082;1046.199657262195;1061.6708820265742;1073.6778966310076;1083.6532309660834;1108.6895669212633;15578.45475408378;15912.443064492687;15926.840731592767;16169.919150404172;16173.191340432932;697796;708789;712124;712254;714240;56572.43427565671;57488.71255643695;57837.71081144567;57954.710226448595;58069.12896306559;1351.945922163122;1365.3651052260548;1389.465055953445;1390.4994202087241;1396.5810256922882;24879.626805597567;30435.847820760755;31002.0699379019;31079.689203108584;31944.201394965312;51541.96916061583;51884.74057629688;52319;52483.47516524786;52551;602629;603954;603966;604598;605611;27142.72857271402;27365;27497.587536186573;27651.03221387242;27708.30729231785;49172;50200.744981375756;50973.98052038864;51148;51516.48483515117;33655.495167573;35211;35349.64650353567;35970.8201458991;41109;34452.310953781285;36971.70599029021;38853;39303;40351.59648403478;33373.498192580904;38680.61319386883;41259.38110928278;41436.378454323814;42460.363094554225;32362.676373235965;36384.27231455303;36813.63186368102;36895.262094758495;37364.564289307506;26032.8698356507;26352.34119147037;26606.467870642868;26792.866035669696;27023.864880676258 11:08:10 INFO - PROCESS | 1656 | |2;jquery.html;350.9631488693687;351.53246182577175;370.61456085670886;379.0996383588976;394.3296396126585;19724.70412943805;20083.497912552193;20240.797592024075;21025.684614730773;21269.149234030658;19859.404217873485;20271.885046322448;20597.382078537667;20698.793012069877;20717.68923466149;5411.269478620376;5772.393898640646;5972.432618901197;5982.760689572412;6022.909656355158;5936.139259807325;5986.5210783137245;5990.460858522732;5991.131285963533;5996.820095397145;5854.570353303374;5916.497097746696;5928.110783382505;5937.970310148443;5943.85140371492;5688.061469857468;5722.027255366577;5770.711464426762;5887.617304875191;5930.377310382412;4982.352294201767;5085.110105731482;5166.199239117943;5168.948310516885;5182.870428239286;20917.686234706493;24676;25242.621360679605;25378.746212538008;25491.74508254912;2040.1431398812385;2159.449340418199;2283.212291759357;2536.441982763789;3065.601471808673;9994.150497207746;10023.59905603775;10070.9496452518;10105.39367637944;10209.723784526934;1832.688442964699;1854.3231720422084;1933.5939452714947;1936.3029309448586;1972.36884197057;93769.5311523438;117600;123399;123699;126417;11018.39398833072;11130.332180069221;11287.322760634388;11495.482703278205;11879.58421455245;14052.648683782987;14055.367508462145;14183.85816141846;14233.85766142346;14245.287735613385;8051.718189863327;8384.245417912418;8395.24442800151;8443.915560844436;8458.703945361884;7121.9643901780155;8228.300594449538;8252.638314678132;8328.709050097244;8428.199321064489;4365.4761428628135;4390.648748100144;4421.624161946206;4479.216137175981;4512.210363186429;1913.2825190553542;1941.6796228622402;1951.6974868895345;1954.140178321534;1954.2769175405192;865.8744482050193;886.5567216391804;900.3067637918766;927.888653361601;986.8207492046935;20495.69256461154;21023.579528409347;21092;21122.943852807297;21173;769.2960940739162;929.4887811703536;942.6512190489426;946.5172761891484;952.4333021852126;8489.533075680896;11121.110311175087;11137.721556960978;11167.497462614201;11167.553297867995;583331;599095;605005;609178;617950;117565;123873.38063309625;126911.36544317404;135780;136447;425.1263653192719;445.2764258080619;448.6993714211486;450.08857064444106;451.3432955050394;9390.436573805593;10202.622645942703;10883.095458294925;10974.341539507655;11139.443027848738;41081.767546973635;44534.3319850209;52804;54105.178964208106;54645;80243;80329.1967080345;80622.59688701518;81192;81621;6998.720051197895;8127;8190.549519776469;8206.384521160817;8230.559652060745;11045.723856903642;11624.535018599161;12233.021358291136;13135.474581016651;13329;11026;11046.668599942015;11419.14356423255;11431.314121152758;11484.942575287405;10894.891051089704;11042.503087360927;11263.887361126612;11381.601643942422;11410.315381077162;9408;11121.833172502256;11307.830382544103;11529.636424532782;11652.475638596114;7690.769276921477;7960.960195198987;8083.474574152661;8168.264856162974;8233.917660823316;7905.802354941173;8020.598970051591;8167.918320816716;8173.425371008113;8244.793880153044 11:08:10 INFO - PROCESS | 1656 | |3;mootools.html;1524.9161296128716;1549.3028137338197;1735.895846249225;1835.8439532639725;1837.7610910581614;7976;8514.659413623456;8589.527575983318;9050.45697258165;9076.546172691373;8705.303575713944;8812.735617931456;8899.510526921016;8912.46525208488;8915.465072095663;2326.7440581536016;2344.6717459555675;2368.8578685278853;2375.3824005758543;2383.6662867198606;2335.077644330497;2357.0571771291534;2357.870317132557;2369.644553316999;2391.784739373456;2365.6924599802087;2371.264907878563;2373.549025685123;2376.58409778289;2391.270662447953;2316.6409206573007;2342.227065068532;2355.5995480768224;2369.7393286738443;2373.4185124644573;2334.8482348647453;2338.0647740903605;2366.148186652804;2367.455485238405;2368.4434157972864;7451.7764467065535;8983.146601072887;8990.730278091667;8998.55007249635;9012.324075694349;5228.764705588258;5358.035553600351;5374.167004114369;5378.596605254622;5380.650257733235;3476.0962149841225;3484.860605575774;3514.5431093957623;3571.321448924696;3575.3206890690944;1037.460520529328;1043.4521876015076;1044.7962647283782;1054.4674939155755;1057.428988346292;11681.890220429046;11726;11752.942235198787;11803.173777835555;11815.818418158202;4416.823327066945;4548.11311794197;4796.016816552598;4812.51874812523;4819.397575303087;9870.901290987142;9999.400035997864;10001.099901008944;10034.69895903124;10049.648262310784;5337.386200586904;5366.651167674088;5389.218563308298;5389.487998640123;5391.56867450603;4389.473263208435;4740.952590474051;4870.9269360959615;4872.731999740048;4907.3620429343955;3894.182221733411;3946.1713040261293;4002.4396584478195;4046.635802777764;4119.846442995966;1285.081166965624;1290.399964016718;1297.6561211279018;1300.8048792681172;1305.9673508162373;775.6780935911646;887.7691800132012;898.6944438890808;909.9954500227457;948.0945696859483;4805.7597120143855;5026.949730502722;5907.616004959664;6123.418275263843;6242.750289988349;939.7509659940122;958.8801399825022;986.3194395866828;1005.7385079879137;1034.8085604163102;3910.7849068300948;3921.764694118362;3995.5005624296964;4040.939385909214;4119.134981653826;10252;10583.470826458646;10586.153107751361;10602.787944241227;10638.042576168182;10486.423246721351;10547.367157970546;10563.841542376871;10580.047795698423;10597.417142057107;8041.758747237593;8315.417920745489;8329.125441828643;8432.578371081421;8538.188872057144;5359.490848369399;5406.24312596229;5816.563757718103;5938.554608404474;6157.445829875153;8376.162383761575;9735.172510336417;10125.189984801345;10281.228907831794;10316.123129534073;9771.560279787285;10187.847182292124;10355.896441035493;10364.274500784873;10365.429901355195;7050.929490705027;7517.962410187914;7601.239876012354;7716.344110750649;7717.151113377637;8570.74287771368;8634.481931084156;8640.438371505832;8664.523451210243;8668.523231222343;7474.551526908403;7635.23647635232;7663.080430348394;7721.80695482595;7724.497907635986;7427.7771666850085;7443.36731377839;7501.924980750123;7507.812304692427;7650.043744531934;7039.1553013638695;7193.848984162509;7194.820129496805;7194.856102877809;7213.350798427957;5019.594513536215;5046.1673823818655;5079.034983353151;5102.744862756922;5202.97398513005;5108.974455127701;5198.844034678966;5233.738313084406;5285.075111855333;5290.497402746733 11:08:10 INFO - PROCESS | 1656 | |4;prototype.html;282.8290875774294;299.42062109817505;301.54918396996493;304.3896986541983;316.53943512189767;5325.349141766045;5515.338159420875;5656.547476201904;5737.655740655564;5746.367899531048;5519.917201241975;5639.661620302784;5648.604597678164;5648.858778530539;5649.293838270216;4325.950205105393;4326.675499337546;4329.636164608154;4340.849674836155;4347.717398369112;3209;3612.4581312803157;3739.551253849542;3919.9020024499473;4172.645325147366;3531.8940431787087;3681.4845921571;4246.278132717445;4253.1493701259715;4258.276093064186;4255.234057869582;4259.829606815723;4263.25393056217;4281.807318670667;4312.482502099737;3676.8161591920566;3719.107414220595;3725.254949010182;3728.6830619397383;3732.720045996561;4369.322754972953;4783.617310615143;5025.346704928373;5415.702136382497;5564.27664403629;4870.902581948377;4963.741497618575;4973.52751488608;4989.950100498985;5002.774875130628;5357.464253574651;5505.788726480168;5637.915431268534;6004.889095517343;6031.788887388921;3526.612072672004;3645.052286405554;3662.249238906018;3858.2283543291455;4013;5491.697956612385;5717.828465146053;6340.619562826245;6351.650659213741;6400.391962763483;3916.4516967624554;4071.9796401017807;4081.734687245379;4088.386741988666;4092.2224777292217;3824.598417166213;3851.5763266040713;4077.531083925327;4092.877213683594;4095.6313931746286;4796.712197268105;4853.466118726938;4861.156223609229;4875.122477953932;4876.439209490883;5429.104197807396;5471.316085489314;5800;5821.79623713168;5961.642301461839;1178.0340121100614;1360.5782207515701;1377.937992790327;1395.6183378455257;1402.3899603672435;757.3184134279193;805.6294104711898;844.079952851395;857.8241460500583;859.4800145911634;4253.829846806093;4336.50130235027;4607.949462489227;4675.6727029108315;4706.905861882743;4627.773639985407;4657.278121891112;4779.880502987453;5047.2429135629945;5134.48655134491;4171.645410140111;4657.347971284023;4701.78841952113;4732.242841145469;4785.808567657325;2899.420115976771;3241.692039256267;3252.4796032634663;3266.3467306538787;3273.9017829465156;5677.602567820296;6395.584287021422;6431.2604050533855;6451.83863405755;6463.256725476536;5798.971005144947;5835.766569337179;5966.106438377384;6064.545159112996;6381.298057213703;5783.958887400308;6098.69506524672;6317.210348706411;6320.462760665303;6329.132905792802;5740.770369185353;5840.138332217098;6102.420270074336;6183.598066125687;6234.937650623436;5980.641161530322;5983.551233657406;5989.580729348903;6039.63762174271;6087.452129308206;6348.650824204528;6391.456726178327;6406.391392817675;6421.678916054272;6425.742970281136;3282.868685252563;3714.3499887519038;3895.902602434962;3900.395438707005;4163.625273725379;6124.693765311627;6132.41742034506;6138.600990935575;6147.32591322776;6163.702419205703;5498.725063746717;5701.458361455655;6007.399260074132;6051.425114614105;6084.847878802888;4873.878153046202;5785.623934444247;5970.671613061323;6015.639061656315;6018.337982821974;5363.865903352447;5603.859903502282;5854.531637468907;5886.999210134373;5916.319623243382;4813.7593120343145;5741.368449470471;5877.823665290048;6038.275406951194;6058.969705151446;5278.683279003272;5663.405342438985;5872.265966754156;5893.941060589339;5899.351071382059 11:08:10 INFO - PROCESS | 1656 | |5;yui.html;710.7725527831093;722.1875390186041;741.2920660768966;776.9067711874576;814.3770015937807;15197.936144469877;15314.315425303208;16105.83894161058;16136.951098178624;16212.756808647864;10854.837177442345;13085.93457032716;13094.279814610192;13102.73794524109;13106.672333191675;676.5974245324037;838.9161083891623;866.376209129429;870.682200996638;877.5743764274322;856.4818284937617;869.9826003479926;870.3211495033852;870.7170169694842;871.4509858788986;920.6639576554576;921.9492927888963;923.6166990698852;924.8196601662678;925.3753716241544;834.5076404921095;848.5545088828353;890.9287257019423;898.6899519665704;919.5264438814016;656.3666062249904;686.8385929306659;687.9346462086094;688.9621070841101;689.8413364926045;12394.504219831197;14811.481598144013;15063;15155.242237888062;15155.393784248618;11305.208635395526;11639.650810475614;12946.935265323613;13924.746772790397;14217.857821421756;11005.889941100566;11487.023602993755;11488.310701357861;11840.28958262507;11952.70118247042;4571.748553829538;4649.442066951988;4652.116097941414;4688.367070445481;4825.710457372569;107282;107946;108509;110625.44687276593;110630.44684776606;9276.814463710689;10824.891751082547;10891.183161262938;10896.237263391486;10948.288361256493;20744.06651700677;20770.896145519175;20771.896140519202;20817.89591052035;20821.271255505984;7106.92893071073;7685.154632990367;7949.205079492004;7973.122956474783;8006.879896801553;4267.466566679165;4421.911561768811;4598.724076555417;4629.537046295411;4643.233866412072;2909.665388480352;3180.443422401117;3492.9825350873593;3494.73789465786;3512.5609298837644;641.7048157847443;644.6712176789778;654.9312322206194;662.6819126819057;664.0238848892121;573.6902072880598;594.7829042399493;619.4394073363613;637.7130291368902;642.4186111569037;8826.646934122564;9075.183233509017;9088.503836381095;9178.35751497402;9181.311401644769;518.8521271437697;537.4142185018349;546.8578169675833;591.6479694581717;603.9310420555591;3968.047668559525;4001.079751657077;4003.7597744135446;4170.77060761655;4299.634531064832;142998.5700143006;144385;144995;148321;160947;102011;122857.77142228463;124090;125824;125953.37023314825;100766;102306.48846755718;104184.43723344155;107957;110185.44907275413;9430.811383772423;9662.75843103928;9902.504874756378;9973.3018688694;9995.550200240861;57591;57991;58075.41924580869;60502.09246861213;63937.36062639314;73115.63442182755;77653.282135125;83672;92906.07093929245;97362;12554.560590379293;13036.41336139857;13075.41160647754;13234.007449441138;13371.197728136343;15090.773638395212;15112.471063513163;15117.941744077809;15442.45951391696;15587.220638968232;13325.466981320638;13860.4455821766;13929.164250145024;14021.298935053002;14185.290735463392;13739.931300343434;14007.649808754863;14041.719165616834;14186.432542698176;14273.357698903781;13264.270465124126;13348.866511334762;13379.130356526795;13678.794818077937;13854.37655305534;8821.823563528822;9924;10196.184305255414;10867;11378.31730096197;9178.577320515331;10309.793804124025;10582.932989946137;10648.201384896009;10831 11:08:10 INFO - PROCESS | 1656 | __end_tp_report 11:08:10 INFO - PROCESS | 1656 | __start_cc_report 11:08:10 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,406 11:08:10 INFO - PROCESS | 1656 | __end_cc_report 11:08:10 INFO - PROCESS | 1656 | __startTimestamp1470766090618__endTimestamp 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | ------- Summary: start ------- 11:08:10 INFO - PROCESS | 1656 | Number of tests: 6 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5283.39 Median:6091.91 stddev:1594.07 (26.2%) stddev-sans-first:1592.21 11:08:10 INFO - PROCESS | 1656 | Values: 3416.3 3427.3 3455.4 3465.1 3470.8 760.1 936.9 1030.5 1519.6 5710.8 897.5 980.0 1013.1 1025.9 1029.7 857.8 870.4 938.3 957.9 1037.6 751.9 819.1 997.8 5233.1 5286.3 4157.0 5124.6 5202.3 5272.1 5313.7 5255.2 5301.0 5337.3 5346.8 5349.8 5065.6 5263.7 5274.6 5284.2 5296.5 5672.0 5759.5 5784.9 5799.5 5800.8 6190.6 6193.9 6215.3 6220.8 6222.7 6154.8 6223.5 6260.0 6264.8 6302.8 4780.8 5907.2 5916.3 5924.5 5970.1 6312.2 6316.5 6333.7 6353.4 6366.7 6070.9 6142.1 6142.4 6204.9 6225.7 6204.4 6205.3 6221.1 6230.8 6235.4 6178.9 6183.1 6185.7 6190.4 6207.6 6051.5 6090.3 6109.4 6123.4 6142.4 4990.9 5020.8 5035.1 5054.8 5073.3 4482.7 4510.2 4511.9 4515.8 4527.3 5628.4 5762.0 5773.6 5855.4 5872.3 6168.8 6191.4 6198.6 6199.3 6210.0 5848.3 5882.9 5882.9 5912.6 5914.8 5372.0 5416.4 5448.2 5485.4 5511.4 6346.5 6352.7 6360.2 6375.2 6379.9 6022.0 6131.1 6167.9 6171.3 6172.2 4875.6 6107.4 6130.0 6326.5 6350.5 6158.1 6193.2 6194.3 6207.5 6210.0 5948.7 6058.2 6173.6 6198.8 6209.1 4948.5 6020.0 6102.6 6177.3 6193.8 6088.8 6114.1 6141.4 6152.0 6167.8 6001.7 6030.6 6041.2 6047.4 6091.9 6057.5 6109.9 6133.1 6156.9 6178.9 6035.1 6059.0 6061.3 6117.7 6126.7 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:69898.28 Median:21602.49 stddev:156705.50 (725.4%) stddev-sans-first:157058.43 11:08:10 INFO - PROCESS | 1656 | Values: 479.8 497.4 509.7 521.3 525.6 32793.5 39336.0 42290.2 42533.8 42611.0 35152.0 43425.0 43529.0 43597.6 43735.8 9632.5 9818.9 9839.1 9846.2 9846.6 9790.8 9880.5 9892.1 9893.5 9899.9 9922.3 9963.5 9984.7 10004.1 10004.2 9863.4 9942.9 9943.1 9943.1 9946.3 9830.4 9899.9 9926.3 9937.5 9946.5 40498.0 40835.4 41165.2 41183.4 41350.4 3386.0 3489.5 3498.7 3583.4 3902.0 32625.8 32962.8 33412.3 33737.5 33846.7 3244.2 3310.4 3325.2 3382.5 3411.7 389518.0 396949.0 398523.0 398789.0 399259.0 57158.4 57505.0 57516.4 57529.1 57576.4 35461.3 36301.6 36330.5 37245.8 37350.0 16699.3 16880.4 16920.4 16927.2 16928.0 12295.8 12610.8 12671.6 12777.4 12798.8 16401.4 17269.7 20306.8 20322.7 20375.6 6476.6 8098.9 8131.2 8183.8 8222.3 936.4 986.8 996.9 1040.7 1070.8 26861.5 29839.9 30587.5 31143.5 31352.4 1046.2 1061.7 1073.7 1083.7 1108.7 15578.5 15912.4 15926.8 16169.9 16173.2 697796.0 708789.0 712124.0 712254.0 714240.0 56572.4 57488.7 57837.7 57954.7 58069.1 1351.9 1365.4 1389.5 1390.5 1396.6 24879.6 30435.8 31002.1 31079.7 31944.2 51542.0 51884.7 52319.0 52483.5 52551.0 602629.0 603954.0 603966.0 604598.0 605611.0 27142.7 27365.0 27497.6 27651.0 27708.3 49172.0 50200.7 50974.0 51148.0 51516.5 33655.5 35211.0 35349.6 35970.8 41109.0 34452.3 36971.7 38853.0 39303.0 40351.6 33373.5 38680.6 41259.4 41436.4 42460.4 32362.7 36384.3 36813.6 36895.3 37364.6 26032.9 26352.3 26606.5 26792.9 27023.9 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34706.38 Median:20753.45 stddev:100716.91 (485.3%) stddev-sans-first:100966.41 11:08:10 INFO - PROCESS | 1656 | Values: 351.0 351.5 370.6 379.1 394.3 19724.7 20083.5 20240.8 21025.7 21269.1 19859.4 20271.9 20597.4 20698.8 20717.7 5411.3 5772.4 5972.4 5982.8 6022.9 5936.1 5986.5 5990.5 5991.1 5996.8 5854.6 5916.5 5928.1 5938.0 5943.9 5688.1 5722.0 5770.7 5887.6 5930.4 4982.4 5085.1 5166.2 5168.9 5182.9 20917.7 24676.0 25242.6 25378.7 25491.7 2040.1 2159.4 2283.2 2536.4 3065.6 9994.2 10023.6 10070.9 10105.4 10209.7 1832.7 1854.3 1933.6 1936.3 1972.4 93769.5 117600.0 123399.0 123699.0 126417.0 11018.4 11130.3 11287.3 11495.5 11879.6 14052.6 14055.4 14183.9 14233.9 14245.3 8051.7 8384.2 8395.2 8443.9 8458.7 7122.0 8228.3 8252.6 8328.7 8428.2 4365.5 4390.6 4421.6 4479.2 4512.2 1913.3 1941.7 1951.7 1954.1 1954.3 865.9 886.6 900.3 927.9 986.8 20495.7 21023.6 21092.0 21122.9 21173.0 769.3 929.5 942.7 946.5 952.4 8489.5 11121.1 11137.7 11167.5 11167.6 583331.0 599095.0 605005.0 609178.0 617950.0 117565.0 123873.4 126911.4 135780.0 136447.0 425.1 445.3 448.7 450.1 451.3 9390.4 10202.6 10883.1 10974.3 11139.4 41081.8 44534.3 52804.0 54105.2 54645.0 80243.0 80329.2 80622.6 81192.0 81621.0 6998.7 8127.0 8190.5 8206.4 8230.6 11045.7 11624.5 12233.0 13135.5 13329.0 11026.0 11046.7 11419.1 11431.3 11484.9 10894.9 11042.5 11263.9 11381.6 11410.3 9408.0 11121.8 11307.8 11529.6 11652.5 7690.8 7961.0 8083.5 8168.3 8233.9 7905.8 8020.6 8167.9 8173.4 8244.8 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5745.98 Median:4871.83 stddev:3204.84 (65.8%) stddev-sans-first:3198.14 11:08:10 INFO - PROCESS | 1656 | Values: 1524.9 1549.3 1735.9 1835.8 1837.8 7976.0 8514.7 8589.5 9050.5 9076.5 8705.3 8812.7 8899.5 8912.5 8915.5 2326.7 2344.7 2368.9 2375.4 2383.7 2335.1 2357.1 2357.9 2369.6 2391.8 2365.7 2371.3 2373.5 2376.6 2391.3 2316.6 2342.2 2355.6 2369.7 2373.4 2334.8 2338.1 2366.1 2367.5 2368.4 7451.8 8983.1 8990.7 8998.6 9012.3 5228.8 5358.0 5374.2 5378.6 5380.7 3476.1 3484.9 3514.5 3571.3 3575.3 1037.5 1043.5 1044.8 1054.5 1057.4 11681.9 11726.0 11752.9 11803.2 11815.8 4416.8 4548.1 4796.0 4812.5 4819.4 9870.9 9999.4 10001.1 10034.7 10049.6 5337.4 5366.7 5389.2 5389.5 5391.6 4389.5 4741.0 4870.9 4872.7 4907.4 3894.2 3946.2 4002.4 4046.6 4119.8 1285.1 1290.4 1297.7 1300.8 1306.0 775.7 887.8 898.7 910.0 948.1 4805.8 5026.9 5907.6 6123.4 6242.8 939.8 958.9 986.3 1005.7 1034.8 3910.8 3921.8 3995.5 4040.9 4119.1 10252.0 10583.5 10586.2 10602.8 10638.0 10486.4 10547.4 10563.8 10580.0 10597.4 8041.8 8315.4 8329.1 8432.6 8538.2 5359.5 5406.2 5816.6 5938.6 6157.4 8376.2 9735.2 10125.2 10281.2 10316.1 9771.6 10187.8 10355.9 10364.3 10365.4 7050.9 7518.0 7601.2 7716.3 7717.2 8570.7 8634.5 8640.4 8664.5 8668.5 7474.6 7635.2 7663.1 7721.8 7724.5 7427.8 7443.4 7501.9 7507.8 7650.0 7039.2 7193.8 7194.8 7194.9 7213.4 5019.6 5046.2 5079.0 5102.7 5203.0 5109.0 5198.8 5233.7 5285.1 5290.5 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4738.13 Median:5302.02 stddev:1505.69 (28.4%) stddev-sans-first:1472.31 11:08:10 INFO - PROCESS | 1656 | Values: 282.8 299.4 301.5 304.4 316.5 5325.3 5515.3 5656.5 5737.7 5746.4 5519.9 5639.7 5648.6 5648.9 5649.3 4326.0 4326.7 4329.6 4340.8 4347.7 3209.0 3612.5 3739.6 3919.9 4172.6 3531.9 3681.5 4246.3 4253.1 4258.3 4255.2 4259.8 4263.3 4281.8 4312.5 3676.8 3719.1 3725.3 3728.7 3732.7 4369.3 4783.6 5025.3 5415.7 5564.3 4870.9 4963.7 4973.5 4990.0 5002.8 5357.5 5505.8 5637.9 6004.9 6031.8 3526.6 3645.1 3662.2 3858.2 4013.0 5491.7 5717.8 6340.6 6351.7 6400.4 3916.5 4072.0 4081.7 4088.4 4092.2 3824.6 3851.6 4077.5 4092.9 4095.6 4796.7 4853.5 4861.2 4875.1 4876.4 5429.1 5471.3 5800.0 5821.8 5961.6 1178.0 1360.6 1377.9 1395.6 1402.4 757.3 805.6 844.1 857.8 859.5 4253.8 4336.5 4607.9 4675.7 4706.9 4627.8 4657.3 4779.9 5047.2 5134.5 4171.6 4657.3 4701.8 4732.2 4785.8 2899.4 3241.7 3252.5 3266.3 3273.9 5677.6 6395.6 6431.3 6451.8 6463.3 5799.0 5835.8 5966.1 6064.5 6381.3 5784.0 6098.7 6317.2 6320.5 6329.1 5740.8 5840.1 6102.4 6183.6 6234.9 5980.6 5983.6 5989.6 6039.6 6087.5 6348.7 6391.5 6406.4 6421.7 6425.7 3282.9 3714.3 3895.9 3900.4 4163.6 6124.7 6132.4 6138.6 6147.3 6163.7 5498.7 5701.5 6007.4 6051.4 6084.8 4873.9 5785.6 5970.7 6015.6 6018.3 5363.9 5603.9 5854.5 5887.0 5916.3 4813.8 5741.4 5877.8 6038.3 6059.0 5278.7 5663.4 5872.3 5893.9 5899.4 11:08:10 INFO - PROCESS | 1656 | 11:08:10 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24056.71 Median:3740.30 stddev:38291.30 (1023.7%) stddev-sans-first:38358.59 11:08:10 INFO - PROCESS | 1656 | Values: 710.8 722.2 741.3 776.9 814.4 15197.9 15314.3 16105.8 16137.0 16212.8 10854.8 13085.9 13094.3 13102.7 13106.7 676.6 838.9 866.4 870.7 877.6 856.5 870.0 870.3 870.7 871.5 920.7 921.9 923.6 924.8 925.4 834.5 848.6 890.9 898.7 919.5 656.4 686.8 687.9 689.0 689.8 12394.5 14811.5 15063.0 15155.2 15155.4 11305.2 11639.7 12946.9 13924.7 14217.9 11005.9 11487.0 11488.3 11840.3 11952.7 4571.7 4649.4 4652.1 4688.4 4825.7 107282.0 107946.0 108509.0 110625.4 110630.4 9276.8 10824.9 10891.2 10896.2 10948.3 20744.1 20770.9 20771.9 20817.9 20821.3 7106.9 7685.2 7949.2 7973.1 8006.9 4267.5 4421.9 4598.7 4629.5 4643.2 2909.7 3180.4 3493.0 3494.7 3512.6 641.7 644.7 654.9 662.7 664.0 573.7 594.8 619.4 637.7 642.4 8826.6 9075.2 9088.5 9178.4 9181.3 518.9 537.4 546.9 591.6 603.9 3968.0 4001.1 4003.8 4170.8 4299.6 142998.6 144385.0 144995.0 148321.0 160947.0 102011.0 122857.8 124090.0 125824.0 125953.4 100766.0 102306.5 104184.4 107957.0 110185.4 9430.8 9662.8 9902.5 9973.3 9995.6 57591.0 57991.0 58075.4 60502.1 63937.4 73115.6 77653.3 83672.0 92906.1 97362.0 12554.6 13036.4 13075.4 13234.0 13371.2 15090.8 15112.5 15117.9 15442.5 15587.2 13325.5 13860.4 13929.2 14021.3 14185.3 13739.9 14007.6 14041.7 14186.4 14273.4 13264.3 13348.9 13379.1 13678.8 13854.4 8821.8 9924.0 10196.2 10867.0 11378.3 9178.6 10309.8 10582.9 10648.2 10831.0 11:08:10 INFO - PROCESS | 1656 | -------- Summary: end -------- 11:08:10 INFO - PROCESS | 1656 | 11:08:11 INFO - TEST-INFO | 1656: exit 0 11:08:11 INFO - TEST-OK | dromaeo_css | took 1127915ms 11:08:11 INFO - TEST-START | kraken 11:08:11 INFO - operating with platform_type : mac_ 11:08:11 INFO - Initialising browser for kraken test... 11:08:11 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpznqk3Z/profile http://localhost:49271/getInfo.html) 11:08:13 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 11:08:13 INFO - PROCESS | 1668 | colorDepth:24 11:08:13 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 11:08:13 INFO - PROCESS | 1668 | __metrics 11:08:14 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:08:14 INFO - TEST-INFO | 1668: exit 0 11:08:14 INFO - Browser initialized. 11:08:14 INFO - Running cycle 1/1 for kraken test... 11:08:14 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpznqk3Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:26 INFO - PROCESS | 1670 | RSS: Main: 254300160 11:08:26 INFO - PROCESS | 1670 | 11:08:29 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 11:08:30 INFO - PROCESS | 1670 | RSS: Main: 267186176 11:08:30 INFO - PROCESS | 1670 | 11:08:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 11:08:33 INFO - PROCESS | 1670 | RSS: Main: 275914752 11:08:33 INFO - PROCESS | 1670 | 11:08:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 11:08:38 INFO - PROCESS | 1670 | RSS: Main: 278839296 11:08:38 INFO - PROCESS | 1670 | 11:08:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 11:08:40 INFO - PROCESS | 1670 | RSS: Main: 281239552 11:08:40 INFO - PROCESS | 1670 | 11:08:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:08:43 INFO - PROCESS | 1670 | RSS: Main: 281731072 11:08:43 INFO - PROCESS | 1670 | 11:08:46 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 11:08:46 INFO - PROCESS | 1670 | RSS: Main: 281952256 11:08:46 INFO - PROCESS | 1670 | 11:08:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 11:08:50 INFO - PROCESS | 1670 | RSS: Main: 282263552 11:08:50 INFO - PROCESS | 1670 | 11:08:53 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 11:08:54 INFO - PROCESS | 1670 | RSS: Main: 282365952 11:08:54 INFO - PROCESS | 1670 | 11:08:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:08:56 INFO - PROCESS | 1670 | RSS: Main: 282157056 11:08:56 INFO - PROCESS | 1670 | 11:08:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:08:59 INFO - PROCESS | 1670 | RSS: Main: 282263552 11:08:59 INFO - PROCESS | 1670 | 11:09:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:09:01 INFO - PROCESS | 1670 | RSS: Main: 282619904 11:09:01 INFO - PROCESS | 1670 | 11:09:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:09:05 INFO - PROCESS | 1670 | RSS: Main: 282710016 11:09:05 INFO - PROCESS | 1670 | 11:09:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:09:09 INFO - PROCESS | 1670 | RSS: Main: 282587136 11:09:09 INFO - PROCESS | 1670 | 11:09:10 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 11:09:11 INFO - PROCESS | 1670 | RSS: Main: 283545600 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | __start_tp_report 11:09:11 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 11:09:11 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 11:09:11 INFO - PROCESS | 1670 | |i|pagename|runs| 11:09:11 INFO - PROCESS | 1670 | |0;ai-astar;106;119;107;120;119;117;117;95;173;121 11:09:11 INFO - PROCESS | 1670 | |1;audio-beat-detection;148;122;172;179;111;145;161;129;161;127 11:09:11 INFO - PROCESS | 1670 | |2;audio-dft;203;211;254;272;198;199;192;198;193;195 11:09:11 INFO - PROCESS | 1670 | |3;audio-fft;69;81;73;150;62;67;74;94;167;84 11:09:11 INFO - PROCESS | 1670 | |4;audio-oscillator;71;72;119;72;73;72;110;70;65;118 11:09:11 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;92;89;89;85;89;86;90;101;113;86 11:09:11 INFO - PROCESS | 1670 | |6;imaging-darkroom;94;94;95;113;128;94;94;94;95;95 11:09:11 INFO - PROCESS | 1670 | |7;imaging-desaturate;96;117;119;90;99;147;94;90;108;99 11:09:11 INFO - PROCESS | 1670 | |8;json-parse-financial;55;57;58;54;52;57;55;55;55;57 11:09:11 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;65;71;70;73;98;108;114;115;73;75 11:09:11 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;88;84;85;85;84;85;104;109;106 11:09:11 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;135;165;158;143;145;158;151;176;166;160 11:09:11 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;176;172;168;168;175;170;169;167;166;166 11:09:11 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;70;76;66;65;74;88;89;91;61;86 11:09:11 INFO - PROCESS | 1670 | __end_tp_report 11:09:11 INFO - PROCESS | 1670 | __start_cc_report 11:09:11 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1067 11:09:11 INFO - PROCESS | 1670 | __end_cc_report 11:09:11 INFO - PROCESS | 1670 | __startTimestamp1470766151208__endTimestamp 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | ------- Summary: start ------- 11:09:11 INFO - PROCESS | 1670 | Number of tests: 14 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:119.40 Median:119.50 stddev:20.59 (17.2%) stddev-sans-first:21.26 11:09:11 INFO - PROCESS | 1670 | Values: 106.0 119.0 107.0 120.0 119.0 117.0 117.0 95.0 173.0 121.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:154.50 stddev:22.78 (14.7%) stddev-sans-first:24.14 11:09:11 INFO - PROCESS | 1670 | Values: 148.0 122.0 172.0 179.0 111.0 145.0 161.0 129.0 161.0 127.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:211.50 Median:201.00 stddev:28.00 (13.9%) stddev-sans-first:29.53 11:09:11 INFO - PROCESS | 1670 | Values: 203.0 211.0 254.0 272.0 198.0 199.0 192.0 198.0 193.0 195.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:92.10 Median:73.50 stddev:36.39 (49.5%) stddev-sans-first:37.62 11:09:11 INFO - PROCESS | 1670 | Values: 69.0 81.0 73.0 150.0 62.0 67.0 74.0 94.0 167.0 84.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:71.50 stddev:21.95 (30.7%) stddev-sans-first:22.75 11:09:11 INFO - PROCESS | 1670 | Values: 71.0 72.0 119.0 72.0 73.0 72.0 110.0 70.0 65.0 118.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:89.00 stddev:8.65 (9.7%) stddev-sans-first:9.18 11:09:11 INFO - PROCESS | 1670 | Values: 92.0 89.0 89.0 85.0 89.0 86.0 90.0 101.0 113.0 86.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:94.00 stddev:11.58 (12.3%) stddev-sans-first:12.10 11:09:11 INFO - PROCESS | 1670 | Values: 94.0 94.0 95.0 113.0 128.0 94.0 94.0 94.0 95.0 95.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:105.90 Median:92.00 stddev:17.73 (19.3%) stddev-sans-first:18.44 11:09:11 INFO - PROCESS | 1670 | Values: 96.0 117.0 119.0 90.0 99.0 147.0 94.0 90.0 108.0 99.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.78 (3.2%) stddev-sans-first:1.88 11:09:11 INFO - PROCESS | 1670 | Values: 55.0 57.0 58.0 54.0 52.0 57.0 55.0 55.0 55.0 57.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:86.20 Median:72.00 stddev:20.09 (27.9%) stddev-sans-first:19.79 11:09:11 INFO - PROCESS | 1670 | Values: 65.0 71.0 70.0 73.0 98.0 108.0 114.0 115.0 73.0 75.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:85.00 stddev:10.24 (12.0%) stddev-sans-first:10.72 11:09:11 INFO - PROCESS | 1670 | Values: 87.0 88.0 84.0 85.0 85.0 84.0 85.0 104.0 109.0 106.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:159.00 stddev:12.29 (7.7%) stddev-sans-first:10.51 11:09:11 INFO - PROCESS | 1670 | Values: 135.0 165.0 158.0 143.0 145.0 158.0 151.0 176.0 166.0 160.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:169.50 stddev:3.56 (2.1%) stddev-sans-first:2.96 11:09:11 INFO - PROCESS | 1670 | Values: 176.0 172.0 168.0 168.0 175.0 170.0 169.0 167.0 166.0 166.0 11:09:11 INFO - PROCESS | 1670 | 11:09:11 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:81.00 stddev:11.16 (13.8%) stddev-sans-first:11.58 11:09:11 INFO - PROCESS | 1670 | Values: 70.0 76.0 66.0 65.0 74.0 88.0 89.0 91.0 61.0 86.0 11:09:11 INFO - PROCESS | 1670 | -------- Summary: end -------- 11:09:11 INFO - PROCESS | 1670 | 11:09:12 INFO - TEST-INFO | 1670: exit 0 11:09:12 INFO - TEST-OK | kraken | took 60806ms 11:09:12 INFO - SUITE-END | took 1188s 11:09:12 INFO - Completed test suite (00:19:49) 11:09:12 INFO - javascript benchmark 11:09:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7143.276032993437, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.333814906094, 3427.3316703242867, 3455.378031954247, 3465.116395319194, 3470.8264586770656, 760.0977268505952, 936.8963937951762, 1030.5122078330735, 1519.597306713719, 5710.800121995726, 897.5027953783078, 979.9959083673887, 1013.0913704607922, 1025.9020303479383, 1029.675652169568, 857.837630011332, 870.3689824876946, 938.2579773714258, 957.9473128977938, 1037.6251019717859, 751.9360854327389, 819.0860672681712, 997.8435600862605, 5233.058049551079, 5286.286351342558, 4157.043879907608, 5124.641275110744, 5202.271681964528, 5272.103742363807, 5313.654612450178, 5255.159174532057, 5301.0, 5337.279467271907, 5346.839594812123, 5349.839504814861, 5065.594752419797, 5263.684178949237, 5274.604404669665, 5284.154535274338, 5296.523312901857, 5672.035753921843, 5759.452851979056, 5784.855378615526, 5799.5070419014855, 5800.8259752207505, 6190.597611155261, 6193.876122477525, 6215.34738852414, 6220.7511699532415, 6222.688865556704, 6154.784582539679, 6223.533235007392, 6259.96870015647, 6264.812055638338, 6302.833975714508, 4780.760961951889, 5907.172995780594, 5916.319623243296, 5924.526037916957, 5970.0746384310505, 6312.179416675803, 6316.463100636405, 6333.68331583419, 6353.396427339396, 6366.745330186741, 6070.939290607126, 6142.1266513713745, 6142.3759981611065, 6204.875902481925, 6225.719842607094, 6204.441600255998, 6205.317415084427, 6221.06683997404, 6230.7507699691505, 6235.407636274546, 6178.876422471615, 6183.103449999725, 6185.690715464209, 6190.380961903864, 6207.6275423474735, 6051.546134039964, 6090.33006369299, 6109.358517355614, 6123.435141503484, 6142.385761423911, 4990.8752281193265, 5020.824271150492, 5035.1188542005, 5054.7978080876355, 5073.340465739504, 4482.731036137842, 4510.188166130062, 4511.864644060618, 4515.751633660115, 4527.3435351873795, 5628.409017053233, 5762.0, 5773.595848290579, 5855.443732845458, 5872.265966754156, 6168.845778855475, 6191.4118158774845, 6198.597091189148, 6199.3490683478485, 6209.96895015531, 5848.2689663792025, 5882.911756323573, 5882.911756323573, 5912.615679980788, 5914.763409463573, 5372.0, 5416.431274716098, 5448.182772584144, 5485.424030476743, 5511.393746687781, 6346.524010699124, 6352.714127864165, 6360.204974378203, 6375.203099612549, 6379.936200637934, 6021.969890150521, 6131.080337949344, 6167.938320616737, 6171.259448866164, 6172.22847144107, 4875.609951203966, 6107.401224262618, 6129.969350153221, 6326.525510586633, 6350.460210882126, 6158.107074474086, 6193.194884664965, 6194.349593292639, 6207.534434917309, 6209.975354066529, 5948.672822994777, 6058.182145410489, 6173.629582225081, 6198.783042593487, 6209.0996805462055, 4948.505149485023, 6020.0, 6102.633841969496, 6177.320494745664, 6193.81418557444, 6088.822718060938, 6114.054067497291, 6141.385861413823, 6152.046432802923, 6167.784127555514, 6001.7299221536005, 6030.638161710312, 6041.18444010053, 6047.425494578008, 6091.9086213707715, 6057.454829065406, 6109.877802444015, 6133.080037994337, 6156.876862462636, 6178.876422471435, 6035.124906888389, 6059.0, 6061.272647282178, 6117.694115294128, 6126.663033533198], "value": 4874.922599524602, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.79608666316807, 497.3832447764773, 509.74512743628185, 521.2780299285488, 525.6097621790364, 32793.50809737856, 39336.0, 42290.15419691608, 42533.78733106334, 42611.0, 35152.0, 43425.0, 43529.0, 43597.564024359745, 43735.78132109343, 9632.47021413822, 9818.90181098187, 9839.114479696862, 9846.212303015742, 9846.55690493926, 9790.755231119243, 9880.505974701273, 9892.060254275832, 9893.4558599277, 9899.901000990007, 9922.255830812683, 9963.501824908763, 9984.700458986243, 10004.099631033205, 10004.199664026897, 9863.408195508257, 9942.90057099427, 9943.105120539187, 9943.105120539187, 9946.303758736927, 9830.410175389428, 9899.851502227473, 9926.255530835217, 9937.503124843728, 9946.452945088018, 40498.0, 40835.38746918798, 41165.176696465904, 41183.38224926629, 41350.37974430386, 3386.0, 3489.45913383426, 3498.7375946803836, 3583.4087375583, 3901.9804900975596, 32625.836870815732, 32962.83518582416, 33412.33175336479, 33737.49393759095, 33846.6615333846, 3244.1889527618096, 3310.4206763816237, 3325.218573635194, 3382.543356646846, 3411.7441191910707, 389518.0, 396949.0, 398523.0, 398789.0, 399259.0, 57158.42841571531, 57505.0, 57516.42483575195, 57529.137062944086, 57576.42423575794, 35461.290774184374, 36301.636983629825, 36330.45504317437, 37245.813770930974, 37350.0, 16699.332026718796, 16880.409185678443, 16920.40778572744, 16927.238274277686, 16927.984320940785, 12295.754084918251, 12610.81083783744, 12671.556495522613, 12777.425015874307, 12798.808017879739, 16401.42595009169, 17269.740953885703, 20306.796932030786, 20322.67902586327, 20375.592488150152, 6476.6114033158165, 8098.919010809935, 8131.15409606633, 8183.79540511492, 8222.342212623096, 936.391345625349, 986.7779749556292, 996.8704068471052, 1040.7086015915556, 1070.7590792071721, 26861.462770744474, 29839.85080074586, 30587.541186882216, 31143.547482845937, 31352.37295254082, 1046.199657262195, 1061.6708820265742, 1073.6778966310076, 1083.6532309660834, 1108.6895669212633, 15578.45475408378, 15912.443064492687, 15926.840731592767, 16169.919150404172, 16173.191340432932, 697796.0, 708789.0, 712124.0, 712254.0, 714240.0, 56572.43427565671, 57488.71255643695, 57837.71081144567, 57954.710226448595, 58069.12896306559, 1351.945922163122, 1365.3651052260548, 1389.465055953445, 1390.4994202087241, 1396.5810256922882, 24879.626805597567, 30435.847820760755, 31002.0699379019, 31079.689203108584, 31944.201394965312, 51541.96916061583, 51884.74057629688, 52319.0, 52483.47516524786, 52551.0, 602629.0, 603954.0, 603966.0, 604598.0, 605611.0, 27142.72857271402, 27365.0, 27497.587536186573, 27651.03221387242, 27708.30729231785, 49172.0, 50200.744981375756, 50973.98052038864, 51148.0, 51516.48483515117, 33655.495167573, 35211.0, 35349.64650353567, 35970.8201458991, 41109.0, 34452.310953781285, 36971.70599029021, 38853.0, 39303.0, 40351.59648403478, 33373.498192580904, 38680.61319386883, 41259.38110928278, 41436.378454323814, 42460.363094554225, 32362.676373235965, 36384.27231455303, 36813.63186368102, 36895.262094758495, 37364.564289307506, 26032.8698356507, 26352.34119147037, 26606.467870642868, 26792.866035669696, 27023.864880676258], "value": 19996.24227213256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9631488693687, 351.53246182577175, 370.61456085670886, 379.0996383588976, 394.3296396126585, 19724.70412943805, 20083.497912552193, 20240.797592024075, 21025.684614730773, 21269.149234030658, 19859.404217873485, 20271.885046322448, 20597.382078537667, 20698.793012069877, 20717.68923466149, 5411.269478620376, 5772.393898640646, 5972.432618901197, 5982.760689572412, 6022.909656355158, 5936.139259807325, 5986.5210783137245, 5990.460858522732, 5991.131285963533, 5996.820095397145, 5854.570353303374, 5916.497097746696, 5928.110783382505, 5937.970310148443, 5943.85140371492, 5688.061469857468, 5722.027255366577, 5770.711464426762, 5887.617304875191, 5930.377310382412, 4982.352294201767, 5085.110105731482, 5166.199239117943, 5168.948310516885, 5182.870428239286, 20917.686234706493, 24676.0, 25242.621360679605, 25378.746212538008, 25491.74508254912, 2040.1431398812385, 2159.449340418199, 2283.212291759357, 2536.441982763789, 3065.601471808673, 9994.150497207746, 10023.59905603775, 10070.9496452518, 10105.39367637944, 10209.723784526934, 1832.688442964699, 1854.3231720422084, 1933.5939452714947, 1936.3029309448586, 1972.36884197057, 93769.5311523438, 117600.0, 123399.0, 123699.0, 126417.0, 11018.39398833072, 11130.332180069221, 11287.322760634388, 11495.482703278205, 11879.58421455245, 14052.648683782987, 14055.367508462145, 14183.85816141846, 14233.85766142346, 14245.287735613385, 8051.718189863327, 8384.245417912418, 8395.24442800151, 8443.915560844436, 8458.703945361884, 7121.9643901780155, 8228.300594449538, 8252.638314678132, 8328.709050097244, 8428.199321064489, 4365.4761428628135, 4390.648748100144, 4421.624161946206, 4479.216137175981, 4512.210363186429, 1913.2825190553542, 1941.6796228622402, 1951.6974868895345, 1954.140178321534, 1954.2769175405192, 865.8744482050193, 886.5567216391804, 900.3067637918766, 927.888653361601, 986.8207492046935, 20495.69256461154, 21023.579528409347, 21092.0, 21122.943852807297, 21173.0, 769.2960940739162, 929.4887811703536, 942.6512190489426, 946.5172761891484, 952.4333021852126, 8489.533075680896, 11121.110311175087, 11137.721556960978, 11167.497462614201, 11167.553297867995, 583331.0, 599095.0, 605005.0, 609178.0, 617950.0, 117565.0, 123873.38063309625, 126911.36544317404, 135780.0, 136447.0, 425.1263653192719, 445.2764258080619, 448.6993714211486, 450.08857064444106, 451.3432955050394, 9390.436573805593, 10202.622645942703, 10883.095458294925, 10974.341539507655, 11139.443027848738, 41081.767546973635, 44534.3319850209, 52804.0, 54105.178964208106, 54645.0, 80243.0, 80329.1967080345, 80622.59688701518, 81192.0, 81621.0, 6998.720051197895, 8127.0, 8190.549519776469, 8206.384521160817, 8230.559652060745, 11045.723856903642, 11624.535018599161, 12233.021358291136, 13135.474581016651, 13329.0, 11026.0, 11046.668599942015, 11419.14356423255, 11431.314121152758, 11484.942575287405, 10894.891051089704, 11042.503087360927, 11263.887361126612, 11381.601643942422, 11410.315381077162, 9408.0, 11121.833172502256, 11307.830382544103, 11529.636424532782, 11652.475638596114, 7690.769276921477, 7960.960195198987, 8083.474574152661, 8168.264856162974, 8233.917660823316, 7905.802354941173, 8020.598970051591, 8167.918320816716, 8173.425371008113, 8244.793880153044], "value": 9051.186169649549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.9161296128716, 1549.3028137338197, 1735.895846249225, 1835.8439532639725, 1837.7610910581614, 7976.0, 8514.659413623456, 8589.527575983318, 9050.45697258165, 9076.546172691373, 8705.303575713944, 8812.735617931456, 8899.510526921016, 8912.46525208488, 8915.465072095663, 2326.7440581536016, 2344.6717459555675, 2368.8578685278853, 2375.3824005758543, 2383.6662867198606, 2335.077644330497, 2357.0571771291534, 2357.870317132557, 2369.644553316999, 2391.784739373456, 2365.6924599802087, 2371.264907878563, 2373.549025685123, 2376.58409778289, 2391.270662447953, 2316.6409206573007, 2342.227065068532, 2355.5995480768224, 2369.7393286738443, 2373.4185124644573, 2334.8482348647453, 2338.0647740903605, 2366.148186652804, 2367.455485238405, 2368.4434157972864, 7451.7764467065535, 8983.146601072887, 8990.730278091667, 8998.55007249635, 9012.324075694349, 5228.764705588258, 5358.035553600351, 5374.167004114369, 5378.596605254622, 5380.650257733235, 3476.0962149841225, 3484.860605575774, 3514.5431093957623, 3571.321448924696, 3575.3206890690944, 1037.460520529328, 1043.4521876015076, 1044.7962647283782, 1054.4674939155755, 1057.428988346292, 11681.890220429046, 11726.0, 11752.942235198787, 11803.173777835555, 11815.818418158202, 4416.823327066945, 4548.11311794197, 4796.016816552598, 4812.51874812523, 4819.397575303087, 9870.901290987142, 9999.400035997864, 10001.099901008944, 10034.69895903124, 10049.648262310784, 5337.386200586904, 5366.651167674088, 5389.218563308298, 5389.487998640123, 5391.56867450603, 4389.473263208435, 4740.952590474051, 4870.9269360959615, 4872.731999740048, 4907.3620429343955, 3894.182221733411, 3946.1713040261293, 4002.4396584478195, 4046.635802777764, 4119.846442995966, 1285.081166965624, 1290.399964016718, 1297.6561211279018, 1300.8048792681172, 1305.9673508162373, 775.6780935911646, 887.7691800132012, 898.6944438890808, 909.9954500227457, 948.0945696859483, 4805.7597120143855, 5026.949730502722, 5907.616004959664, 6123.418275263843, 6242.750289988349, 939.7509659940122, 958.8801399825022, 986.3194395866828, 1005.7385079879137, 1034.8085604163102, 3910.7849068300948, 3921.764694118362, 3995.5005624296964, 4040.939385909214, 4119.134981653826, 10252.0, 10583.470826458646, 10586.153107751361, 10602.787944241227, 10638.042576168182, 10486.423246721351, 10547.367157970546, 10563.841542376871, 10580.047795698423, 10597.417142057107, 8041.758747237593, 8315.417920745489, 8329.125441828643, 8432.578371081421, 8538.188872057144, 5359.490848369399, 5406.24312596229, 5816.563757718103, 5938.554608404474, 6157.445829875153, 8376.162383761575, 9735.172510336417, 10125.189984801345, 10281.228907831794, 10316.123129534073, 9771.560279787285, 10187.847182292124, 10355.896441035493, 10364.274500784873, 10365.429901355195, 7050.929490705027, 7517.962410187914, 7601.239876012354, 7716.344110750649, 7717.151113377637, 8570.74287771368, 8634.481931084156, 8640.438371505832, 8664.523451210243, 8668.523231222343, 7474.551526908403, 7635.23647635232, 7663.080430348394, 7721.80695482595, 7724.497907635986, 7427.7771666850085, 7443.36731377839, 7501.924980750123, 7507.812304692427, 7650.043744531934, 7039.1553013638695, 7193.848984162509, 7194.820129496805, 7194.856102877809, 7213.350798427957, 5019.594513536215, 5046.1673823818655, 5079.034983353151, 5102.744862756922, 5202.97398513005, 5108.974455127701, 5198.844034678966, 5233.738313084406, 5285.075111855333, 5290.497402746733], "value": 4624.726275899096, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.8290875774294, 299.42062109817505, 301.54918396996493, 304.3896986541983, 316.53943512189767, 5325.349141766045, 5515.338159420875, 5656.547476201904, 5737.655740655564, 5746.367899531048, 5519.917201241975, 5639.661620302784, 5648.604597678164, 5648.858778530539, 5649.293838270216, 4325.950205105393, 4326.675499337546, 4329.636164608154, 4340.849674836155, 4347.717398369112, 3209.0, 3612.4581312803157, 3739.551253849542, 3919.9020024499473, 4172.645325147366, 3531.8940431787087, 3681.4845921571, 4246.278132717445, 4253.1493701259715, 4258.276093064186, 4255.234057869582, 4259.829606815723, 4263.25393056217, 4281.807318670667, 4312.482502099737, 3676.8161591920566, 3719.107414220595, 3725.254949010182, 3728.6830619397383, 3732.720045996561, 4369.322754972953, 4783.617310615143, 5025.346704928373, 5415.702136382497, 5564.27664403629, 4870.902581948377, 4963.741497618575, 4973.52751488608, 4989.950100498985, 5002.774875130628, 5357.464253574651, 5505.788726480168, 5637.915431268534, 6004.889095517343, 6031.788887388921, 3526.612072672004, 3645.052286405554, 3662.249238906018, 3858.2283543291455, 4013.0, 5491.697956612385, 5717.828465146053, 6340.619562826245, 6351.650659213741, 6400.391962763483, 3916.4516967624554, 4071.9796401017807, 4081.734687245379, 4088.386741988666, 4092.2224777292217, 3824.598417166213, 3851.5763266040713, 4077.531083925327, 4092.877213683594, 4095.6313931746286, 4796.712197268105, 4853.466118726938, 4861.156223609229, 4875.122477953932, 4876.439209490883, 5429.104197807396, 5471.316085489314, 5800.0, 5821.79623713168, 5961.642301461839, 1178.0340121100614, 1360.5782207515701, 1377.937992790327, 1395.6183378455257, 1402.3899603672435, 757.3184134279193, 805.6294104711898, 844.079952851395, 857.8241460500583, 859.4800145911634, 4253.829846806093, 4336.50130235027, 4607.949462489227, 4675.6727029108315, 4706.905861882743, 4627.773639985407, 4657.278121891112, 4779.880502987453, 5047.2429135629945, 5134.48655134491, 4171.645410140111, 4657.347971284023, 4701.78841952113, 4732.242841145469, 4785.808567657325, 2899.420115976771, 3241.692039256267, 3252.4796032634663, 3266.3467306538787, 3273.9017829465156, 5677.602567820296, 6395.584287021422, 6431.2604050533855, 6451.83863405755, 6463.256725476536, 5798.971005144947, 5835.766569337179, 5966.106438377384, 6064.545159112996, 6381.298057213703, 5783.958887400308, 6098.69506524672, 6317.210348706411, 6320.462760665303, 6329.132905792802, 5740.770369185353, 5840.138332217098, 6102.420270074336, 6183.598066125687, 6234.937650623436, 5980.641161530322, 5983.551233657406, 5989.580729348903, 6039.63762174271, 6087.452129308206, 6348.650824204528, 6391.456726178327, 6406.391392817675, 6421.678916054272, 6425.742970281136, 3282.868685252563, 3714.3499887519038, 3895.902602434962, 3900.395438707005, 4163.625273725379, 6124.693765311627, 6132.41742034506, 6138.600990935575, 6147.32591322776, 6163.702419205703, 5498.725063746717, 5701.458361455655, 6007.399260074132, 6051.425114614105, 6084.847878802888, 4873.878153046202, 5785.623934444247, 5970.671613061323, 6015.639061656315, 6018.337982821974, 5363.865903352447, 5603.859903502282, 5854.531637468907, 5886.999210134373, 5916.319623243382, 4813.7593120343145, 5741.368449470471, 5877.823665290048, 6038.275406951194, 6058.969705151446, 5278.683279003272, 5663.405342438985, 5872.265966754156, 5893.941060589339, 5899.351071382059], "value": 4243.434921977617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7725527831093, 722.1875390186041, 741.2920660768966, 776.9067711874576, 814.3770015937807, 15197.936144469877, 15314.315425303208, 16105.83894161058, 16136.951098178624, 16212.756808647864, 10854.837177442345, 13085.93457032716, 13094.279814610192, 13102.73794524109, 13106.672333191675, 676.5974245324037, 838.9161083891623, 866.376209129429, 870.682200996638, 877.5743764274322, 856.4818284937617, 869.9826003479926, 870.3211495033852, 870.7170169694842, 871.4509858788986, 920.6639576554576, 921.9492927888963, 923.6166990698852, 924.8196601662678, 925.3753716241544, 834.5076404921095, 848.5545088828353, 890.9287257019423, 898.6899519665704, 919.5264438814016, 656.3666062249904, 686.8385929306659, 687.9346462086094, 688.9621070841101, 689.8413364926045, 12394.504219831197, 14811.481598144013, 15063.0, 15155.242237888062, 15155.393784248618, 11305.208635395526, 11639.650810475614, 12946.935265323613, 13924.746772790397, 14217.857821421756, 11005.889941100566, 11487.023602993755, 11488.310701357861, 11840.28958262507, 11952.70118247042, 4571.748553829538, 4649.442066951988, 4652.116097941414, 4688.367070445481, 4825.710457372569, 107282.0, 107946.0, 108509.0, 110625.44687276593, 110630.44684776606, 9276.814463710689, 10824.891751082547, 10891.183161262938, 10896.237263391486, 10948.288361256493, 20744.06651700677, 20770.896145519175, 20771.896140519202, 20817.89591052035, 20821.271255505984, 7106.92893071073, 7685.154632990367, 7949.205079492004, 7973.122956474783, 8006.879896801553, 4267.466566679165, 4421.911561768811, 4598.724076555417, 4629.537046295411, 4643.233866412072, 2909.665388480352, 3180.443422401117, 3492.9825350873593, 3494.73789465786, 3512.5609298837644, 641.7048157847443, 644.6712176789778, 654.9312322206194, 662.6819126819057, 664.0238848892121, 573.6902072880598, 594.7829042399493, 619.4394073363613, 637.7130291368902, 642.4186111569037, 8826.646934122564, 9075.183233509017, 9088.503836381095, 9178.35751497402, 9181.311401644769, 518.8521271437697, 537.4142185018349, 546.8578169675833, 591.6479694581717, 603.9310420555591, 3968.047668559525, 4001.079751657077, 4003.7597744135446, 4170.77060761655, 4299.634531064832, 142998.5700143006, 144385.0, 144995.0, 148321.0, 160947.0, 102011.0, 122857.77142228463, 124090.0, 125824.0, 125953.37023314825, 100766.0, 102306.48846755718, 104184.43723344155, 107957.0, 110185.44907275413, 9430.811383772423, 9662.75843103928, 9902.504874756378, 9973.3018688694, 9995.550200240861, 57591.0, 57991.0, 58075.41924580869, 60502.09246861213, 63937.36062639314, 73115.63442182755, 77653.282135125, 83672.0, 92906.07093929245, 97362.0, 12554.560590379293, 13036.41336139857, 13075.41160647754, 13234.007449441138, 13371.197728136343, 15090.773638395212, 15112.471063513163, 15117.941744077809, 15442.45951391696, 15587.220638968232, 13325.466981320638, 13860.4455821766, 13929.164250145024, 14021.298935053002, 14185.290735463392, 13739.931300343434, 14007.649808754863, 14041.719165616834, 14186.432542698176, 14273.357698903781, 13264.270465124126, 13348.866511334762, 13379.130356526795, 13678.794818077937, 13854.37655305534, 8821.823563528822, 9924.0, 10196.184305255414, 10867.0, 11378.31730096197, 9178.577320515331, 10309.793804124025, 10582.932989946137, 10648.201384896009, 10831.0], "value": 7672.069968413648, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 107.0, 120.0, 119.0, 117.0, 117.0, 95.0, 173.0, 121.0], "value": 119.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 172.0, 179.0, 111.0, 145.0, 161.0, 129.0, 161.0, 127.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 211.0, 254.0, 272.0, 198.0, 199.0, 192.0, 198.0, 193.0, 195.0], "value": 211.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 73.0, 150.0, 62.0, 67.0, 74.0, 94.0, 167.0, 84.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 119.0, 72.0, 73.0, 72.0, 110.0, 70.0, 65.0, 118.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 89.0, 85.0, 89.0, 86.0, 90.0, 101.0, 113.0, 86.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 113.0, 128.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 99.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 117.0, 119.0, 90.0, 99.0, 147.0, 94.0, 90.0, 108.0, 99.0], "value": 105.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 58.0, 54.0, 52.0, 57.0, 55.0, 55.0, 55.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 70.0, 73.0, 98.0, 108.0, 114.0, 115.0, 73.0, 75.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 84.0, 85.0, 85.0, 84.0, 85.0, 104.0, 109.0, 106.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 165.0, 158.0, 143.0, 145.0, 158.0, 151.0, 176.0, 166.0, 160.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 168.0, 168.0, 175.0, 170.0, 169.0, 167.0, 166.0, 166.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 66.0, 65.0, 74.0, 88.0, 89.0, 91.0, 61.0, 86.0], "value": 76.6, "unit": "score"}]}]} 11:09:12 INFO - Return code: 0 11:09:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:09:12 ERROR - # TBPL SUCCESS # 11:09:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:09:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:09:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:09:12 INFO - 2016-08-09 11:09:12.481 screenresolution[1675:10385] starting screenresolution argv=screenresolution get 11:09:12 INFO - 2016-08-09 11:09:12.484 screenresolution[1675:10385] Display 0: 1600x1200x32@60 11:09:12 INFO - 2016-08-09 11:09:12.491 screenresolution[1676:10388] starting screenresolution argv=screenresolution list 11:09:12 INFO - Available Modes on Display 0 11:09:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:09:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:09:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:09:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:09:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:09:12 INFO - Intel Iris: 11:09:12 INFO - Chipset Model: Intel Iris 11:09:12 INFO - Type: GPU 11:09:12 INFO - Bus: Built-In 11:09:12 INFO - VRAM (Dynamic, Max): 1536 MB 11:09:12 INFO - Vendor: Intel (0x8086) 11:09:12 INFO - Device ID: 0x0a2e 11:09:12 INFO - Revision ID: 0x0009 11:09:12 INFO - Displays: 11:09:12 INFO - Display: 11:09:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:09:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:09:12 INFO - Display Serial Number: 1600x1200 60 11:09:12 INFO - Main Display: Yes 11:09:12 INFO - Mirror: Off 11:09:12 INFO - Online: Yes 11:09:12 INFO - Rotation: Supported 11:09:12 INFO - Return code: 0 11:09:12 INFO - Running post-action listener: _resource_record_post_action 11:09:12 INFO - [mozharness: 2016-08-09 18:09:12.725687Z] Finished run-tests step (success) 11:09:12 INFO - Running post-run listener: _resource_record_post_run 11:09:12 INFO - Total resource usage - Wall time: 1223s; CPU: 56.0%; Read bytes: 38589440; Write bytes: 703518208; Read time: 402; Write time: 2216 11:09:12 INFO - TinderboxPrint: CPU usage
55.6% 11:09:12 INFO - TinderboxPrint: I/O read bytes / time
38,589,440 / 402 11:09:12 INFO - TinderboxPrint: I/O write bytes / time
703,518,208 / 2,216 11:09:12 INFO - TinderboxPrint: CPU idle
2,172.3 (44.4%) 11:09:12 INFO - TinderboxPrint: CPU system
975.9 (19.9%) 11:09:12 INFO - TinderboxPrint: CPU user
1,745.5 (35.7%) 11:09:12 INFO - TinderboxPrint: Swap in / out
441,614,336 / 0 11:09:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382243328; Write bytes: 377384448; Read time: 28247; Write time: 724 11:09:12 INFO - run-tests - Wall time: 1190s; CPU: 56.0%; Read bytes: 37667840; Write bytes: 296617984; Read time: 389; Write time: 1437 11:09:13 INFO - Running post-run listener: _upload_blobber_files 11:09:13 INFO - Blob upload gear active. 11:09:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:09:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:09:13 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'] 11:09:13 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 11:09:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:09:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:09:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:09:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:14 INFO - (blobuploader) - INFO - Done attempting. 11:09:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:09:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:09:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:15 INFO - (blobuploader) - INFO - Done attempting. 11:09:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:09:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:09:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:17 INFO - (blobuploader) - INFO - Done attempting. 11:09:17 INFO - (blobuploader) - INFO - Iteration through files over. 11:09:17 INFO - Return code: 0 11:09:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:09:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:09:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/334db0aba5a821d817982116a0e2fb75e9158ccc9539fea5c1cb2c7351ba463e5d4910b4a447347c81979140898b5421f8e5983fdac28fe0de2a520fa32f551d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e0cf7096a3251dfd6caa9ee605be9465b4ba52ff2ae10060b9c8cd41a656984d274c4b80a080d4adac54b98bf55d9db28653f5241eef4b08bc312f7be10a22c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/18341a8a257dc4bfc31ab5c2ce3878dea87fae2f326d47182dcaff0ce47709c6ed4032a1c068811eae047f105b82adcab2ecfd94ef098182d773aefef27d16b8"} 11:09:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:09:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:09:17 INFO - Contents: 11:09:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/334db0aba5a821d817982116a0e2fb75e9158ccc9539fea5c1cb2c7351ba463e5d4910b4a447347c81979140898b5421f8e5983fdac28fe0de2a520fa32f551d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e0cf7096a3251dfd6caa9ee605be9465b4ba52ff2ae10060b9c8cd41a656984d274c4b80a080d4adac54b98bf55d9db28653f5241eef4b08bc312f7be10a22c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/18341a8a257dc4bfc31ab5c2ce3878dea87fae2f326d47182dcaff0ce47709c6ed4032a1c068811eae047f105b82adcab2ecfd94ef098182d773aefef27d16b8"} 11:09:17 INFO - Running post-run listener: copy_logs_to_upload_dir 11:09:17 INFO - Copying logs to upload dir... 11:09:17 INFO - mkdir: /builds/slave/test/build/upload/logs 11:09:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.024476 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-09 11:09:18.083470) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 11:09:18.089913) ========= 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.NZFsOpmchE/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.VT4VxugMsn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/334db0aba5a821d817982116a0e2fb75e9158ccc9539fea5c1cb2c7351ba463e5d4910b4a447347c81979140898b5421f8e5983fdac28fe0de2a520fa32f551d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e0cf7096a3251dfd6caa9ee605be9465b4ba52ff2ae10060b9c8cd41a656984d274c4b80a080d4adac54b98bf55d9db28653f5241eef4b08bc312f7be10a22c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/18341a8a257dc4bfc31ab5c2ce3878dea87fae2f326d47182dcaff0ce47709c6ed4032a1c068811eae047f105b82adcab2ecfd94ef098182d773aefef27d16b8"} build_url:https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010511 build_url: 'https://queue.taskcluster.net/v1/task/ZOLzf1hoSJ6s0yX5_IAPKg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/334db0aba5a821d817982116a0e2fb75e9158ccc9539fea5c1cb2c7351ba463e5d4910b4a447347c81979140898b5421f8e5983fdac28fe0de2a520fa32f551d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e0cf7096a3251dfd6caa9ee605be9465b4ba52ff2ae10060b9c8cd41a656984d274c4b80a080d4adac54b98bf55d9db28653f5241eef4b08bc312f7be10a22c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/18341a8a257dc4bfc31ab5c2ce3878dea87fae2f326d47182dcaff0ce47709c6ed4032a1c068811eae047f105b82adcab2ecfd94ef098182d773aefef27d16b8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 11:09:18.128373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 11:09:18.128705) ========= 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.NZFsOpmchE/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.VT4VxugMsn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 11:09:18.176986) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 11:09:18.177283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 11:09:18.180660) ========= ========= Total master_lag: 0.54 =========