builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0224 starttime: 1470691415.78 results: success (0) buildid: 20160808131625 builduid: 943c4d1a2b8849bf92740c4753819dea revision: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:35.784632) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:35.785000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:35.785287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:35.878534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:35.879070) ========= 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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-08 14:23:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-08-08 14:23:36 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.610004 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.545694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.546027) ========= 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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.019883 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:36.613687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 14:23:36.614020) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fc6ed18f76e16d3e2a392c93fd77b867e12955e4 --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 fc6ed18f76e16d3e2a392c93fd77b867e12955e4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UWgijSv8JU/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.p3OkZ8bYWO/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-08 14:23:36,702 truncating revision to first 12 chars 2016-08-08 14:23:36,702 Setting DEBUG logging. 2016-08-08 14:23:36,702 attempt 1/10 2016-08-08 14:23:36,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fc6ed18f76e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 14:23:38,354 unpacking tar archive at: autoland-fc6ed18f76e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.920961 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 14:23:38.561910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.562232) ========= script_repo_revision: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.562721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.563029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 14:23:38.591082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-08-08 14:23:38.591620) ========= /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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:23:38 INFO - MultiFileLogger online at 20160808 14:23:38 in /builds/slave/test 14:23:38 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 14:23:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:38 INFO - {'append_to_log': False, 14:23:38 INFO - 'base_work_dir': '/builds/slave/test', 14:23:38 INFO - 'blob_upload_branch': 'Autoland', 14:23:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:38 INFO - 'branch': 'Autoland', 14:23:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:38 INFO - 'config_files': ('talos/mac_config.py',), 14:23:38 INFO - 'default_actions': ('clobber', 14:23:38 INFO - 'read-buildbot-config', 14:23:38 INFO - 'download-and-extract', 14:23:38 INFO - 'populate-webroot', 14:23:38 INFO - 'create-virtualenv', 14:23:38 INFO - 'install', 14:23:38 INFO - 'run-tests'), 14:23:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:38 INFO - 'download_minidump_stackwalk': True, 14:23:38 INFO - 'download_symbols': 'ondemand', 14:23:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:38 INFO - 'installer_path': 'installer.exe', 14:23:38 INFO - 'log_level': 'info', 14:23:38 INFO - 'log_name': 'talos', 14:23:38 INFO - 'log_to_console': True, 14:23:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:23:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:23:38 INFO - 'opt_config_files': (), 14:23:38 INFO - 'pip_index': False, 14:23:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:38 INFO - 'cmd': ('bash', 14:23:38 INFO - '-c', 14:23:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:38 INFO - 'enabled': True, 14:23:38 INFO - 'halt_on_failure': False, 14:23:38 INFO - 'name': 'check_screen_resolution'},), 14:23:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:38 INFO - 'cmd': ('bash', 14:23:38 INFO - '-c', 14:23:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:38 INFO - 'enabled': True, 14:23:38 INFO - 'halt_on_failure': False, 14:23:38 INFO - 'name': 'check_screen_resolution'},), 14:23:38 INFO - 'run_cmd_checks_enabled': True, 14:23:38 INFO - 'sps_profile': False, 14:23:38 INFO - 'sps_profile_interval': 0, 14:23:38 INFO - 'suite': 'dromaeojs-e10s', 14:23:38 INFO - 'system_bits': '32', 14:23:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:38 INFO - 'title': 't-yosemite-r7-0224', 14:23:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:38 INFO - 'use_talos_json': True, 14:23:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:38 INFO - 'work_dir': 'build'} 14:23:38 INFO - [mozharness: 2016-08-08 21:23:38.786835Z] Running clobber step. 14:23:38 INFO - Running pre-action listener: _resource_record_pre_action 14:23:38 INFO - Running main action method: clobber 14:23:38 INFO - rmtree: /builds/slave/test/build 14:23:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:39 INFO - Running post-action listener: _resource_record_post_action 14:23:39 INFO - [mozharness: 2016-08-08 21:23:39.232857Z] Finished clobber step (success) 14:23:39 INFO - [mozharness: 2016-08-08 21:23:39.232997Z] Running read-buildbot-config step. 14:23:39 INFO - Running pre-action listener: _resource_record_pre_action 14:23:39 INFO - Running main action method: read_buildbot_config 14:23:39 INFO - Using buildbot properties: 14:23:39 INFO - { 14:23:39 INFO - "project": "", 14:23:39 INFO - "product": "firefox", 14:23:39 INFO - "script_repo_revision": "production", 14:23:39 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 14:23:39 INFO - "repository": "", 14:23:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 14:23:39 INFO - "buildid": "20160808131625", 14:23:39 INFO - "pgo_build": "False", 14:23:39 INFO - "basedir": "/builds/slave/test", 14:23:39 INFO - "buildnumber": 86, 14:23:39 INFO - "slavename": "t-yosemite-r7-0224", 14:23:39 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:23:39 INFO - "platform": "yosemite_r7", 14:23:39 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:23:39 INFO - "branch": "autoland", 14:23:39 INFO - "repo_path": "integration/autoland", 14:23:39 INFO - "revision": "fc6ed18f76e16d3e2a392c93fd77b867e12955e4", 14:23:39 INFO - "stage_platform": "macosx64", 14:23:39 INFO - "builduid": "943c4d1a2b8849bf92740c4753819dea", 14:23:39 INFO - "slavebuilddir": "test" 14:23:39 INFO - } 14:23:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:23:39 INFO - Running post-action listener: _resource_record_post_action 14:23:39 INFO - [mozharness: 2016-08-08 21:23:39.236371Z] Finished read-buildbot-config step (success) 14:23:39 INFO - [mozharness: 2016-08-08 21:23:39.236480Z] Running download-and-extract step. 14:23:39 INFO - Running pre-action listener: _resource_record_pre_action 14:23:39 INFO - Running main action method: download_and_extract 14:23:39 INFO - mkdir: /builds/slave/test/build/tests 14:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:39 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:23:39 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:40 INFO - Downloaded 1199 bytes. 14:23:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:23:40 INFO - Using the following test package requirements: 14:23:40 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:23:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:23:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:23:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'jsshell-mac.zip'], 14:23:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:23:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:23:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:23:40 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:23:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:23:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:23:40 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:23:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:40 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:23:40 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:41 INFO - Downloaded 16324283 bytes. 14:23:41 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'] 14:23:41 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 14:23:44 INFO - Return code: 0 14:23:44 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 14:23:44 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')]} 14:23:44 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:23:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:46 INFO - Downloaded 16324283 bytes. 14:23:46 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'] 14:23:46 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 14:23:49 INFO - Return code: 0 14:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:49 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:23:49 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:51 INFO - Downloaded 14413723 bytes. 14:23:51 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'] 14:23:51 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 14:23:51 INFO - Return code: 0 14:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:51 INFO - trying https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:23:51 INFO - Downloading https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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 14:23:55 INFO - Downloaded 111977502 bytes. 14:23:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:23:55 INFO - mkdir: /builds/slave/test/properties 14:23:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:55 INFO - Contents: 14:23:55 INFO - build_url:https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:23:56 INFO - Running post-action listener: _resource_record_post_action 14:23:56 INFO - Running post-action listener: set_extra_try_arguments 14:23:56 INFO - [mozharness: 2016-08-08 21:23:56.113073Z] Finished download-and-extract step (success) 14:23:56 INFO - [mozharness: 2016-08-08 21:23:56.113183Z] Running populate-webroot step. 14:23:56 INFO - Running pre-action listener: _resource_record_pre_action 14:23:56 INFO - Running main action method: populate_webroot 14:23:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:56 INFO - '--tppagecycles', 14:23:56 INFO - '7'], 14:23:56 INFO - 'tests': ['tsvgm']}}, 14:23:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['damp', 'tps']}, 14:23:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'tests': ['damp', 'tps']}, 14:23:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['dromaeo_dom']}, 14:23:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['basic_compositor_video']}, 14:23:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:23:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['a11yr', 14:23:56 INFO - 'ts_paint', 14:23:56 INFO - 'tpaint', 14:23:56 INFO - 'sessionrestore', 14:23:56 INFO - 'sessionrestore_no_auto_restore', 14:23:56 INFO - 'tabpaint']}, 14:23:56 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:56 INFO - 'ts_paint', 14:23:56 INFO - 'tpaint', 14:23:56 INFO - 'sessionrestore', 14:23:56 INFO - 'sessionrestore_no_auto_restore', 14:23:56 INFO - 'tabpaint']}, 14:23:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:56 INFO - 'ts_paint', 14:23:56 INFO - 'tpaint', 14:23:56 INFO - 'sessionrestore', 14:23:56 INFO - 'sessionrestore_no_auto_restore', 14:23:56 INFO - 'tabpaint']}, 14:23:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:56 INFO - 'ts_paint', 14:23:56 INFO - 'tpaint', 14:23:56 INFO - 'sessionrestore', 14:23:56 INFO - 'sessionrestore_no_auto_restore', 14:23:56 INFO - 'tabpaint']}, 14:23:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['a11yr', 14:23:56 INFO - 'ts_paint', 14:23:56 INFO - 'tpaint', 14:23:56 INFO - 'sessionrestore', 14:23:56 INFO - 'sessionrestore_no_auto_restore', 14:23:56 INFO - 'tabpaint']}, 14:23:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['a11yr', 14:23:56 INFO - 'ts_paint', 14:23:56 INFO - 'tpaint', 14:23:56 INFO - 'sessionrestore', 14:23:56 INFO - 'sessionrestore_no_auto_restore', 14:23:56 INFO - 'tabpaint']}, 14:23:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['tsvgx', 14:23:56 INFO - 'tsvgr_opacity', 14:23:56 INFO - 'tart', 14:23:56 INFO - 'tscrollx', 14:23:56 INFO - 'cart']}, 14:23:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:56 INFO - 'tsvgr_opacity', 14:23:56 INFO - 'tart', 14:23:56 INFO - 'tscrollx', 14:23:56 INFO - 'cart']}, 14:23:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'talos_options': ['--disable-e10s'], 14:23:56 INFO - 'tests': ['tp5o']}, 14:23:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'tests': ['tp5o']}, 14:23:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'talos_options': ['--disable-e10s', 14:23:56 INFO - '--xperf_path', 14:23:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:56 INFO - 'tests': ['tp5n']}, 14:23:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:56 INFO - 'talos_options': ['--xperf_path', 14:23:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:56 INFO - 'tests': ['tp5n']}}, 14:23:56 INFO - 'talos.zip': {'path': '', 14:23:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:56 INFO - Running post-action listener: _resource_record_post_action 14:23:56 INFO - [mozharness: 2016-08-08 21:23:56.132088Z] Finished populate-webroot step (success) 14:23:56 INFO - [mozharness: 2016-08-08 21:23:56.132236Z] Running create-virtualenv step. 14:23:56 INFO - Running pre-action listener: _resource_record_pre_action 14:23:56 INFO - Running main action method: create_virtualenv 14:23:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:56 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 14:23:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:56 INFO - Using real prefix '/tools/python27' 14:23:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:56 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:59 INFO - Installing pip.................done. 14:23:59 INFO - Return code: 0 14:23:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:23:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:23:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:59 INFO - 'HOME': '/Users/cltbld', 14:23:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:59 INFO - 'LOGNAME': 'cltbld', 14:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:59 INFO - 'MOZ_NO_REMOTE': '1', 14:23:59 INFO - 'NO_EM_RESTART': '1', 14:23:59 INFO - 'PAGER': '/bin/cat', 14:23:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:59 INFO - 'PWD': '/builds/slave/test', 14:23:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:59 INFO - 'SHELL': '/bin/bash', 14:23:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:23:59 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:23:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:59 INFO - 'USER': 'cltbld', 14:23:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:59 INFO - 'XPC_FLAGS': '0x0', 14:23:59 INFO - 'XPC_SERVICE_NAME': '0', 14:23:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:00 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 14:24:00 INFO - Cleaning up... 14:24:00 INFO - Return code: 0 14:24:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:00 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')]} 14:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:00 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')]} 14:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:00 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:00 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 14:24:00 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 14:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:00 INFO - 'HOME': '/Users/cltbld', 14:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:00 INFO - 'LOGNAME': 'cltbld', 14:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:00 INFO - 'MOZ_NO_REMOTE': '1', 14:24:00 INFO - 'NO_EM_RESTART': '1', 14:24:00 INFO - 'PAGER': '/bin/cat', 14:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:00 INFO - 'PWD': '/builds/slave/test', 14:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:00 INFO - 'SHELL': '/bin/bash', 14:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:00 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:00 INFO - 'USER': 'cltbld', 14:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:00 INFO - 'XPC_FLAGS': '0x0', 14:24:00 INFO - 'XPC_SERVICE_NAME': '0', 14:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:00 INFO - Downloading/unpacking psutil>=3.1.1 14:24:00 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 14:24:00 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 14:24:00 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 14:24:00 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 14:24:00 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 14:24:00 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 14:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:04 INFO - Installing collected packages: psutil 14:24:04 INFO - Running setup.py install for psutil 14:24:04 INFO - building 'psutil._psutil_osx' extension 14:24:04 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 14:24:04 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 14:24:04 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 14:24:04 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 14:24:04 INFO - building 'psutil._psutil_posix' extension 14:24:04 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 14:24:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:24:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:24:04 INFO - ^ 14:24:04 INFO - 1 warning generated. 14:24:04 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 14:24:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:05 INFO - Successfully installed psutil 14:24:05 INFO - Cleaning up... 14:24:05 INFO - Return code: 0 14:24:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:05 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')]} 14:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:05 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')]} 14:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:05 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:05 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 14:24:05 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 14:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:05 INFO - 'HOME': '/Users/cltbld', 14:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:05 INFO - 'LOGNAME': 'cltbld', 14:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:05 INFO - 'MOZ_NO_REMOTE': '1', 14:24:05 INFO - 'NO_EM_RESTART': '1', 14:24:05 INFO - 'PAGER': '/bin/cat', 14:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:05 INFO - 'PWD': '/builds/slave/test', 14:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:05 INFO - 'SHELL': '/bin/bash', 14:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:05 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:05 INFO - 'USER': 'cltbld', 14:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:05 INFO - 'XPC_FLAGS': '0x0', 14:24:05 INFO - 'XPC_SERVICE_NAME': '0', 14:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:07 INFO - Installing collected packages: mozsystemmonitor 14:24:07 INFO - Running setup.py install for mozsystemmonitor 14:24:08 INFO - Successfully installed mozsystemmonitor 14:24:08 INFO - Cleaning up... 14:24:08 INFO - Return code: 0 14:24:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:08 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:08 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 14:24:08 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 14:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:08 INFO - 'HOME': '/Users/cltbld', 14:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:08 INFO - 'LOGNAME': 'cltbld', 14:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:08 INFO - 'MOZ_NO_REMOTE': '1', 14:24:08 INFO - 'NO_EM_RESTART': '1', 14:24:08 INFO - 'PAGER': '/bin/cat', 14:24:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:08 INFO - 'PWD': '/builds/slave/test', 14:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:08 INFO - 'SHELL': '/bin/bash', 14:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:08 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:08 INFO - 'USER': 'cltbld', 14:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:08 INFO - 'XPC_FLAGS': '0x0', 14:24:08 INFO - 'XPC_SERVICE_NAME': '0', 14:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:08 INFO - Downloading/unpacking jsonschema==2.5.1 14:24:08 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 14:24:08 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 14:24:08 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 14:24:08 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 14:24:08 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 14:24:08 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 14:24:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:11 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:11 INFO - warning: no files found matching '*.txt' 14:24:11 INFO - no previously-included directories found matching 'build' 14:24:11 INFO - no previously-included directories found matching 'dist' 14:24:11 INFO - no previously-included directories found matching '.git*' 14:24:11 INFO - Installing collected packages: jsonschema, functools32 14:24:11 INFO - Running setup.py install for functools32 14:24:11 INFO - warning: no files found matching '*.txt' 14:24:11 INFO - no previously-included directories found matching 'build' 14:24:11 INFO - no previously-included directories found matching 'dist' 14:24:11 INFO - no previously-included directories found matching '.git*' 14:24:11 INFO - Successfully installed jsonschema functools32 14:24:11 INFO - Cleaning up... 14:24:11 INFO - Return code: 0 14:24:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24:11 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')]} 14:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:11 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')]} 14:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:11 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:11 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 14:24:11 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 14:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:11 INFO - 'HOME': '/Users/cltbld', 14:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:11 INFO - 'LOGNAME': 'cltbld', 14:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:11 INFO - 'MOZ_NO_REMOTE': '1', 14:24:11 INFO - 'NO_EM_RESTART': '1', 14:24:11 INFO - 'PAGER': '/bin/cat', 14:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:11 INFO - 'PWD': '/builds/slave/test', 14:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:11 INFO - 'SHELL': '/bin/bash', 14:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:11 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:11 INFO - 'USER': 'cltbld', 14:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:11 INFO - 'XPC_FLAGS': '0x0', 14:24:11 INFO - 'XPC_SERVICE_NAME': '0', 14:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:11 INFO - Cleaning up... 14:24:11 INFO - Return code: 0 14:24:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:11 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')]} 14:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:11 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')]} 14:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:11 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:11 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 14:24:11 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 14:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:11 INFO - 'HOME': '/Users/cltbld', 14:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:11 INFO - 'LOGNAME': 'cltbld', 14:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:11 INFO - 'MOZ_NO_REMOTE': '1', 14:24:11 INFO - 'NO_EM_RESTART': '1', 14:24:11 INFO - 'PAGER': '/bin/cat', 14:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:11 INFO - 'PWD': '/builds/slave/test', 14:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:11 INFO - 'SHELL': '/bin/bash', 14:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:11 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:11 INFO - 'USER': 'cltbld', 14:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:11 INFO - 'XPC_FLAGS': '0x0', 14:24:11 INFO - 'XPC_SERVICE_NAME': '0', 14:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:12 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 14:24:12 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 14:24:12 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 14:24:12 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 14:24:12 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 14:24:12 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 14:24:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:14 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 14:24:14 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 14:24:14 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 14:24:14 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 14:24:14 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 14:24:14 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 14:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:15 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 14:24:15 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 14:24:15 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 14:24:15 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 14:24:15 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 14:24:15 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 14:24:15 INFO - Downloading docopt-0.6.1.tar.gz 14:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:15 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:15 INFO - Running setup.py install for blobuploader 14:24:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:16 INFO - Running setup.py install for requests 14:24:16 INFO - Running setup.py install for docopt 14:24:16 INFO - Successfully installed blobuploader requests docopt 14:24:16 INFO - Cleaning up... 14:24:16 INFO - Return code: 0 14:24:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:16 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:16 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 14:24:16 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 14:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:16 INFO - 'HOME': '/Users/cltbld', 14:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:16 INFO - 'LOGNAME': 'cltbld', 14:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:16 INFO - 'MOZ_NO_REMOTE': '1', 14:24:16 INFO - 'NO_EM_RESTART': '1', 14:24:16 INFO - 'PAGER': '/bin/cat', 14:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:16 INFO - 'PWD': '/builds/slave/test', 14:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:16 INFO - 'SHELL': '/bin/bash', 14:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:16 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:16 INFO - 'USER': 'cltbld', 14:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:16 INFO - 'XPC_FLAGS': '0x0', 14:24:16 INFO - 'XPC_SERVICE_NAME': '0', 14:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-UjwOcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-2LAcgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-2Xc1_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-lQgsmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-aER_px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Oql6GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-sIjtPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-7rzO91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:17 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-oxqVr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-7HM3lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ttPQAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-xHC6wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-tx_6k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-s2DFaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nJmJsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ZPATZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:18 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-KICRtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:18 INFO - Running setup.py install for manifestparser 14:24:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:19 INFO - Running setup.py install for mozcrash 14:24:19 INFO - Running setup.py install for mozdebug 14:24:19 INFO - Running setup.py install for mozdevice 14:24:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:24:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:19 INFO - Running setup.py install for mozfile 14:24:19 INFO - Running setup.py install for mozhttpd 14:24:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:19 INFO - Running setup.py install for mozinfo 14:24:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:19 INFO - Running setup.py install for mozInstall 14:24:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Running setup.py install for mozleak 14:24:20 INFO - Running setup.py install for mozlog 14:24:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Running setup.py install for moznetwork 14:24:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Running setup.py install for mozprocess 14:24:20 INFO - Running setup.py install for mozprofile 14:24:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:20 INFO - Running setup.py install for mozrunner 14:24:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:21 INFO - Running setup.py install for mozscreenshot 14:24:21 INFO - Running setup.py install for moztest 14:24:21 INFO - Running setup.py install for mozversion 14:24:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:21 INFO - Cleaning up... 14:24:21 INFO - Return code: 0 14:24:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:21 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:21 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 14:24:21 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 14:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:21 INFO - 'HOME': '/Users/cltbld', 14:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:21 INFO - 'LOGNAME': 'cltbld', 14:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:21 INFO - 'MOZ_NO_REMOTE': '1', 14:24:21 INFO - 'NO_EM_RESTART': '1', 14:24:21 INFO - 'PAGER': '/bin/cat', 14:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:21 INFO - 'PWD': '/builds/slave/test', 14:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:21 INFO - 'SHELL': '/bin/bash', 14:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:21 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:21 INFO - 'USER': 'cltbld', 14:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:21 INFO - 'XPC_FLAGS': '0x0', 14:24:21 INFO - 'XPC_SERVICE_NAME': '0', 14:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:21 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-pe4MgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:21 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)) 14:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:21 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-xaTFY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:21 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)) 14:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:21 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Yq50AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-afvTDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-uxHXNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-aAsRsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nYxulP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-MgBHYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-J46FUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-3NwVeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-KDBncn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:22 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)) 14:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:22 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-gNnXzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:23 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)) 14:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:23 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ilJIdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:23 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)) 14:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:23 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-DYnVJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:23 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)) 14:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:23 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-cDX50j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:23 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)) 14:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:23 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-lKPfrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:23 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)) 14:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:23 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-GvE2vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:23 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)) 14:24:23 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)) 14:24:23 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)) 14:24:23 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)) 14:24:23 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)) 14:24:23 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)) 14:24:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:25 INFO - Downloading blessings-1.6.tar.gz 14:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:26 INFO - Installing collected packages: blessings 14:24:26 INFO - Running setup.py install for blessings 14:24:26 INFO - Successfully installed blessings 14:24:26 INFO - Cleaning up... 14:24:26 INFO - Return code: 0 14:24:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:26 INFO - Reading from file tmpfile_stdout 14:24:26 INFO - Current package versions: 14:24:26 INFO - blessings == 1.6 14:24:26 INFO - blobuploader == 1.2.4 14:24:26 INFO - docopt == 0.6.1 14:24:26 INFO - functools32 == 3.2.3-2 14:24:26 INFO - jsonschema == 2.5.1 14:24:26 INFO - manifestparser == 1.1 14:24:26 INFO - mozInstall == 1.12 14:24:26 INFO - mozcrash == 0.17 14:24:26 INFO - mozdebug == 0.1 14:24:26 INFO - mozdevice == 0.48 14:24:26 INFO - mozfile == 1.2 14:24:26 INFO - mozhttpd == 0.7 14:24:26 INFO - mozinfo == 0.9 14:24:26 INFO - mozleak == 0.1 14:24:26 INFO - mozlog == 3.3 14:24:26 INFO - moznetwork == 0.27 14:24:26 INFO - mozprocess == 0.23 14:24:26 INFO - mozprofile == 0.28 14:24:26 INFO - mozrunner == 6.12 14:24:26 INFO - mozscreenshot == 0.1 14:24:26 INFO - mozsystemmonitor == 0.3 14:24:26 INFO - moztest == 0.7 14:24:26 INFO - mozversion == 1.4 14:24:26 INFO - psutil == 3.1.1 14:24:26 INFO - requests == 1.2.3 14:24:26 INFO - wsgiref == 0.1.2 14:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:26 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24:26 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 14:24:26 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 14:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:26 INFO - 'HOME': '/Users/cltbld', 14:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:26 INFO - 'LOGNAME': 'cltbld', 14:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:26 INFO - 'MOZ_NO_REMOTE': '1', 14:24:26 INFO - 'NO_EM_RESTART': '1', 14:24:26 INFO - 'PAGER': '/bin/cat', 14:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:26 INFO - 'PWD': '/builds/slave/test', 14:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:26 INFO - 'SHELL': '/bin/bash', 14:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:26 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:26 INFO - 'USER': 'cltbld', 14:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:26 INFO - 'XPC_FLAGS': '0x0', 14:24:26 INFO - 'XPC_SERVICE_NAME': '0', 14:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 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)) 14:24:26 INFO - Cleaning up... 14:24:26 INFO - Return code: 0 14:24:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10873c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f953a481770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, '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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 14:24: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', 'jsonschema'] in /builds/slave/test/build 14:24: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 jsonschema 14:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:26 INFO - 'HOME': '/Users/cltbld', 14:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:26 INFO - 'LOGNAME': 'cltbld', 14:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:26 INFO - 'MOZ_NO_REMOTE': '1', 14:24:26 INFO - 'NO_EM_RESTART': '1', 14:24:26 INFO - 'PAGER': '/bin/cat', 14:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:26 INFO - 'PWD': '/builds/slave/test', 14:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:26 INFO - 'SHELL': '/bin/bash', 14:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:24:26 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:26 INFO - 'USER': 'cltbld', 14:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:26 INFO - 'XPC_FLAGS': '0x0', 14:24:26 INFO - 'XPC_SERVICE_NAME': '0', 14:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:24:27 INFO - Cleaning up... 14:24:27 INFO - Return code: 0 14:24:27 INFO - Running post-action listener: _resource_record_post_action 14:24:27 INFO - Running post-action listener: _start_resource_monitoring 14:24:27 INFO - Starting resource monitoring. 14:24:27 INFO - [mozharness: 2016-08-08 21:24:27.173293Z] Finished create-virtualenv step (success) 14:24:27 INFO - [mozharness: 2016-08-08 21:24:27.174319Z] Running install step. 14:24:27 INFO - Running pre-action listener: _resource_record_pre_action 14:24:27 INFO - Running main action method: install 14:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:27 INFO - Reading from file tmpfile_stdout 14:24:27 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:27 INFO - Reading from file tmpfile_stdout 14:24:27 INFO - Output received: 14:24:27 INFO - Usage: mozinstall [options] installer 14:24:27 INFO - Options: 14:24:27 INFO - -h, --help show this help message and exit 14:24:27 INFO - -d DEST, --destination=DEST 14:24:27 INFO - Directory to install application into. [default: 14:24:27 INFO - "/builds/slave/test"] 14:24:27 INFO - --app=APP Application being installed. [default: firefox] 14:24:27 INFO - mkdir: /builds/slave/test/build/application 14:24:27 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'] 14:24:27 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 14:25:01 INFO - Reading from file tmpfile_stdout 14:25:01 INFO - Output received: 14:25:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:25:01 INFO - Running post-action listener: _resource_record_post_action 14:25:01 INFO - [mozharness: 2016-08-08 21:25:01.954079Z] Finished install step (success) 14:25:01 INFO - [mozharness: 2016-08-08 21:25:01.954237Z] Running run-tests step. 14:25:01 INFO - Running pre-action listener: _resource_record_pre_action 14:25:01 INFO - Running main action method: run_tests 14:25:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:01 INFO - 2016-08-08 14:25:01.969 screenresolution[6349:108172] starting screenresolution argv=screenresolution get 14:25:01 INFO - 2016-08-08 14:25:01.972 screenresolution[6349:108172] Display 0: 1600x1200x32@60 14:25:01 INFO - 2016-08-08 14:25:01.978 screenresolution[6350:108174] starting screenresolution argv=screenresolution list 14:25:01 INFO - Available Modes on Display 0 14:25:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:02 INFO - Intel Iris: 14:25:02 INFO - Chipset Model: Intel Iris 14:25:02 INFO - Type: GPU 14:25:02 INFO - Bus: Built-In 14:25:02 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:02 INFO - Vendor: Intel (0x8086) 14:25:02 INFO - Device ID: 0x0a2e 14:25:02 INFO - Revision ID: 0x0009 14:25:02 INFO - Displays: 14:25:02 INFO - Display: 14:25:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:02 INFO - Display Serial Number: 1600x1200 60 14:25:02 INFO - Main Display: Yes 14:25:02 INFO - Mirror: Off 14:25:02 INFO - Online: Yes 14:25:02 INFO - Rotation: Supported 14:25:02 INFO - Return code: 0 14:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:02 INFO - Python 2.7.3 14:25:02 INFO - Return code: 0 14:25:02 INFO - grabbing minidump binary from tooltool 14:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:02 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 0x10860bd30>, '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 0x108370db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108603b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:02 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 14:25:02 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 14:25:02 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 14:25:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:02 INFO - Return code: 0 14:25:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:25:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:25:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:02 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/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 14:25:02 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/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0224 --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 14:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWgijSv8JU/Render', 14:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:02 INFO - 'HOME': '/Users/cltbld', 14:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:02 INFO - 'LOGNAME': 'cltbld', 14:25:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:02 INFO - 'MOZ_NO_REMOTE': '1', 14:25:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:02 INFO - 'NO_EM_RESTART': '1', 14:25:02 INFO - 'PAGER': '/bin/cat', 14:25:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:02 INFO - 'PWD': '/builds/slave/test', 14:25:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:02 INFO - 'SHELL': '/bin/bash', 14:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p3OkZ8bYWO/Listeners', 14:25:02 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 14:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:02 INFO - 'USER': 'cltbld', 14:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:02 INFO - 'XPC_FLAGS': '0x0', 14:25:02 INFO - 'XPC_SERVICE_NAME': '0', 14:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:02 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/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 14:25:02 INFO - mozversion application_buildid: 20160808131625 14:25:02 INFO - mozversion application_changeset: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 14:25:02 INFO - mozversion application_display_name: Nightly 14:25:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:02 INFO - mozversion application_name: Firefox 14:25:02 INFO - mozversion application_remotingname: firefox 14:25:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:25:02 INFO - mozversion application_vendor: Mozilla 14:25:02 INFO - mozversion application_version: 51.0a1 14:25:02 INFO - mozversion platform_buildid: 20160808131625 14:25:02 INFO - mozversion platform_changeset: fc6ed18f76e16d3e2a392c93fd77b867e12955e4 14:25:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:25:02 INFO - mozversion platform_version: 51.0a1 14:25:02 INFO - using testdate: 1470691502 14:25:02 INFO - actual date: 1470691502 14:25:02 INFO - starting webserver on 'localhost:56936' 14:25:02 INFO - SUITE-START | Running 2 tests 14:25:02 INFO - TEST-START | dromaeo_css 14:25:02 INFO - operating with platform_type : mac_ 14:25:02 INFO - Initialising browser for dromaeo_css test... 14:25:02 INFO - TEST-INFO | started process 6360 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmp_3vLW6/profile http://localhost:56936/getInfo.html) 14:25:05 INFO - PROCESS | 6360 | __metrics Screen width/height:1600/1200 14:25:05 INFO - PROCESS | 6360 | colorDepth:24 14:25:05 INFO - PROCESS | 6360 | Browser inner width/height: 1024/689 14:25:05 INFO - PROCESS | 6360 | __metrics 14:25:05 ERROR - PROCESS | 6360 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:25:06 INFO - TEST-INFO | 6360: exit 0 14:25:06 INFO - Browser initialized. 14:25:06 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:06 INFO - TEST-INFO | started process 6364 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmp_3vLW6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:18 INFO - PROCESS | 6364 | RSS: Main: 254676992 14:25:18 INFO - PROCESS | 6364 | 14:26:08 INFO - PROCESS | 6364 | 1470691568063 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] 14:28:20 INFO - PROCESS | 6364 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56936/tests/dromaeo/cssquery-ext.html) 14:28:21 INFO - PROCESS | 6364 | RSS: Main: 270102528 14:28:21 INFO - PROCESS | 6364 | 14:31:24 INFO - PROCESS | 6364 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-ext.html (next: http://localhost:56936/tests/dromaeo/cssquery-jquery.html) 14:31:24 INFO - PROCESS | 6364 | RSS: Main: 281116672 14:31:24 INFO - PROCESS | 6364 | 14:34:26 INFO - PROCESS | 6364 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56936/tests/dromaeo/cssquery-mootools.html) 14:34:27 INFO - PROCESS | 6364 | RSS: Main: 287993856 14:34:27 INFO - PROCESS | 6364 | 14:37:29 INFO - PROCESS | 6364 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56936/tests/dromaeo/cssquery-prototype.html) 14:37:29 INFO - PROCESS | 6364 | RSS: Main: 287531008 14:37:29 INFO - PROCESS | 6364 | 14:40:32 INFO - PROCESS | 6364 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56936/tests/dromaeo/cssquery-yui.html) 14:40:33 INFO - PROCESS | 6364 | RSS: Main: 291725312 14:40:33 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | Cycle 1(1): loaded http://localhost:56936/tests/dromaeo/cssquery-yui.html (next: http://localhost:56936/tests/dromaeo/cssquery-dojo.html) 14:43:35 INFO - PROCESS | 6364 | RSS: Main: 292519936 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | __start_tp_report 14:43:35 INFO - PROCESS | 6364 | _x_x_mozilla_page_load 14:43:35 INFO - PROCESS | 6364 | _x_x_mozilla_page_load_details 14:43:35 INFO - PROCESS | 6364 | |i|pagename|runs| 14:43:35 INFO - PROCESS | 6364 | |0;dojo.html;3389.322135572886;3424.6232914379416;3446.741494387921;3477.947830782539;3489.494023366612;5258.237555554447;5862.824115276538;5879.176915231866;5895.941040589592;5942.76228950842;5856.326522449919;5896.292444906607;5896.823095307137;5909.172715819789;5916.88166236675;5331.840044798662;5378.193271009341;5405.081136206834;5456.61803673743;5472.452754724535;5175.767090480918;5282.656627319231;5337.01265265927;5399.9730001349935;5439.265699130607;4340.544242854487;5353.5984801139875;5358.356997160366;5370.758315875756;5391.272178255944;5354.41101478837;5354.929014197176;5361.839144825662;5364.088105022117;5370.3287089113865;4226.154769046172;5181.689098654055;5226.55574276187;5302.496262855023;5316.0962636351915;4721.693089949176;5835;5872.324682661506;5889.411058894119;5932.9703351483395;6223.5954662947215;6289.119523266746;6294.433500984887;6310.211223597051;6313.053042043684;6187.3503282155625;6196.225471816023;6205.286392064925;6330.113784070234;6335.651539165344;5921.73352199152;5977.312609049928;5993.700314984233;6024.09638554216;6031.698415079229;6412.35876412355;6428.099723431825;6470.288268290485;6474.6762661866715;6481.740730370827;6047.879042419215;6173.59871608344;6185.567010309325;6278;6303.401176888188;6311.147995020705;6312.905306420407;6329;6331.113644089831;6332.461740752087;5349.705766182898;6244.937550624527;6284.12022316876;6310.0850376695125;6317.431431171125;6142.836439233798;6182.969085154546;6192.938070619326;6269.96865015672;6307.337729538424;5098.923516147261;5099.209622508517;5109.054824857413;5126.948730512721;5149.48505149482;4537.069900670354;4554.863354099382;4590.885227869263;4604.631629469634;4636.165490211794;5769.048107062287;5935.970320148372;5945.791897283574;5955.40445955401;5969.492593129546;6309.589876658002;6311.558190926683;6313;6318.589291696117;6334.778282760081;5978.282606087298;6045.093236014545;6046.3349031606485;6063.302720187146;6066.757329706762;5473.698946557977;5519.227308176858;5602.075657516546;5602.775888964396;5604.607677462538;4995.450500445021;6516.446102081376;6519.185101862173;6521.543491955517;6585.242697089704;6304.779332723333;6312.305646378986;6325.588836725598;6335.968320158369;6336.556441049267;6254.4996400286955;6398.776042838478;6415.166028416276;6519.674016299261;6569.080328754074;6249.78125765596;6280.905786413116;6300.0234963580715;6300.653464059521;6345.936540634534;6298.496120310272;6317.684115794284;6320.905186422299;6329.240491141092;6342.048692695948;5537.501624853782;5580.939621471907;6148.4773794227995;6182;6264.843378915563;6238.469730072995;6262.279837818709;6262.906056409066;6276.435120839146;6278.560500764903;5994.13085102649;6091.299500557316;6111.297200821962;6177.320494745484;6197.287311959182;6129.908051379322;6142.57002009855;6145.187169784835;6262.874742505033;6283.654399008098;6090.451859332681;6097.237845269341;6103.428585615297;6112.780907263289;6142.6314421134875 14:43:35 INFO - PROCESS | 6364 | |1;ext.html;479.81287297953793;497.05063329041536;512.1447183204049;521.3951815893562;556.9359523654781;38801.41797873031;41824;41900.95247618811;41952.790236048815;42057.99999999992;43045.7847710761;43092.56907430925;43100;43340.91647708809;43438;9399.530023498832;9492.572834222443;9502.667406640734;9609.711708648752;9632.951835240814;9578.760530986712;9624.47065411402;9645.469499177543;9658.710238692815;9659.903400966006;9616.903830961706;9631.229501639851;9653.71038868835;9672.129508344247;9707.077827606367;9549.331546791727;9628.085331893459;9657.951710241474;9681.467519286436;9696.51517424133;9536.5695145728;9639.614415423444;9645.469499177543;9648.662296819577;9658.227341812708;40801;40970.590294096975;41005.97485062868;41167.97080072992;41179.7941010293;3323.8670453181844;3403.149212696826;3415.6639433850346;3439.518467414564;3818.618138186187;32585;32981.50527742086;33311.000669979694;33331.500027499605;34122.829385852914;3233.692799184097;3263.216827961272;3289.3256882339065;3383.2218589724257;3387.068556147079;486151;493193.53403232753;496104.5194774003;497269;497421.0257897411;34005;59951;59959;59964.50088747816;59966.800663986476;33426.99719008385;34986.475202871974;35021;35375;35786.28427431437;14451.85548144505;14532.782008269884;14652.926735366254;14670.119792812466;14713.264336783332;12148.635540933787;12314.953228975459;12329.50681972729;12434.440450179764;12461.688457788629;7208.27917208275;7379.409647228209;7764.184760600168;7868;7977.880331795028;3181.729552988022;3236.3689080629524;3239.4330992076293;3249.8862539810993;3260.6739326067204;954.5084281594984;987.4519641598981;992.3847214726771;1097.9898493386104;1150.5570355413058;25758.871205643853;30913.381732365226;31175.84412077925;31207.063788086394;31447.84276078605;1006.2855372685475;1029.4801125431609;1079.2930630437077;1110.9833352499556;1164.2025212729138;13621.523246686318;14121.858781412055;16198.239972078924;16348.346066157459;16352.509424717278;705233;706525;712898;716460;717773;43903;44088.338674919905;44226.778866105466;44387;44426.333604995954;1366.7403193393222;1391.0818859552646;1400.3978289335682;1407.5284779598744;1409.605310513058;24184.637230441207;28984;30140.950480229512;30173;30598.235044124074;43043.56956430396;52098.47901520936;52101.478985209666;52263;52404.47595524148;594289;604211;606572;608918;610337;27096.458070838078;27195;27302.180934571996;27656.72343276622;27824;48664.75667621639;49034.509654904425;49606.25590616216;49960;50185.74535636638;41090.79454602708;41299.58700412957;41694;41739.791301043304;41901;40648.79675601603;40836;41196.79401602973;42041;42445.938851527724;39542.802285988386;40013.599864000986;40856;40884.59115408808;42196.789016054725;30342.544861827533;30623;32347.51478727868;36150.63849361578;36331;26108.608370874834;26397.472050559267;26502;26637.866810665822;26768.732312676624 14:43:35 INFO - PROCESS | 6364 | |2;jquery.html;371.67849809914435;378.8730775190311;384.1912773611548;399.32314726538493;407.8633657724662;18979.810201897977;20705;21216.4695882603;21291.787082129173;21403.785962140373;20299.289524866632;20302.18791248348;20903.68644470334;20991.370258892257;21247.893760531177;5960.374160713128;6030.396960303957;6043.184170137041;6065.696715164247;6177.444030037295;4241.554636763141;6010.398960103998;6118.1434599156155;6479.708413121421;6768.966155169217;6782.423494003016;6814.659267036654;6814.659267036654;6816;6833.965830170867;5621.634593751413;5940.138679891392;5971.910421343683;6078.96960515199;6086.969565152146;5263.86840328991;5772.365039845614;5867;5967.343592204854;5969.134475501028;13361.799573006412;13531;13572.93213533926;23093.538129237488;24476.510469790504;2172.326578760589;2364.3261670423844;2518.9118380856767;2605.8924956893243;2925.2979284971666;9932.106110450095;10203.081722644924;10366.533505992173;10446.26876118672;10613.681589552325;1667.3330667732882;1852.8888266704041;1866.2628261836635;1875.7186422036668;1886.1700851625378;107622.46188769085;132428.33785831105;139145.47690707783;140154.59845401518;157030;21846.344609661737;22279.443013924458;22373.776262237494;22467.10131594718;22552.0979160835;36334.63665363366;36370.63629363725;36371;36381.27237455236;36415;10791.190660700478;10955.287906286225;11134.49894754738;11228.943855280671;11229.943850280697;7447.478676492702;9108.513659791244;9126.58930348136;9178.67874624385;9197.678081267257;8345.5409952452;9767.658131965489;10053.346532475513;10219.029192226726;10283.897161028444;1589.8410158984009;1673.3557580331417;1693.796744390681;3724.3296206682517;3894.571597124314;859.4315374441669;861.4874149880811;891.2869704236584;901.9909800901906;936.6487567162314;16314.347426102822;20084.69872951907;21011;21222.83274419922;21355.35933921985;906.619219927632;919.72868003939;952.9428234305825;960.2510042166981;1004.6734811186394;10098.192144628412;10771.461426928623;10972.396518191417;11077.224594278323;11156.944215278872;595312;602277;616648;617132;631418;101714;126627.73372266344;132780.3360983189;142325;147402.26298868438;895.3911340288666;968.8885778135464;1004.9346792458467;1005.3565717940523;1008.8638033865334;18993.14530846143;19264.32574859873;19313.51716207106;19364.70952935679;19428.611427771648;57713.13430298465;58806.82386352334;59558.40441595529;59573;60590.697046514484;87262.56368718116;87848;88467;89281.55359223162;90088.5495572518;6909.723611055501;7116.64783691097;7116.857662846611;8006;8189.344852411912;10531.94734026325;10882.891171088188;12968.610941671765;13389.866101339252;13671.658208544866;11427.60003399877;11515.366654834064;11563.248388854698;11603.477843496894;11714.70713232176;11295.717607059889;11544.307341559534;11632.302061876315;11645.41772911334;11773.234739741889;11559.768804623693;11568.878436975863;11791.705207369885;11923.582674606347;12024;8229.670813167406;8453.239208471266;8455;8636.740897773077;8656.870146947927;10035.34770239932;11515.481803319039;11749.177557570887;11874.643760687193;11894.048476122063 14:43:35 INFO - PROCESS | 6364 | |3;mootools.html;1527.7250094982905;1545.7372246718057;1714.1600615698303;1798.1908141336394;1820.8907465552059;7877.7636670899965;8346.874796878044;8397.118302578234;8907.68823091192;8908.955455222724;8515.403921725481;8686.087960764107;8711.43375680582;8711.825763484727;8712.390132690714;2304.2511183865267;2339.415146213447;2354.281944007077;2354.788069073783;2360.433495960974;2325.7092863392077;2349.9765002349927;2364.645303204516;2382.1424287256573;2397.2328854766483;2361.7520160383083;2363.3382652857226;2365.95268094638;2373.9762602373926;2374.715034195899;2329.94175145621;2337.731160916491;2340.1458467659354;2358.174638876397;2359.1271229645054;2344.4138965258685;2345.812335013212;2348.6594443805725;2353.646952957053;2363.2673871100014;8680;8717.912820871774;8850.380473366868;8868.33487488441;8889.19997200255;5167.4057483389515;5310.840674779763;5338.332708411449;5340.198970154508;5355.143177091647;3397.252604427022;3439.449688049925;3449.258409441957;3509.1051781795736;3512.227309991798;1082.4912291223113;1101.0971003776826;1107.020287045962;1112.1825458288151;1120.9215354925159;9916.405015699009;11071.612493562687;11586.71033224176;11664.650060498114;11683.649490515298;3982.9601703983167;4007.35882258843;4453.0648563801315;4528.343390208402;4621.861344159681;9856.408615483095;9943.154831839374;9945.850812237823;9957.80084398308;9968.900310996798;5202.713850738246;5239.240310155083;5243.868903277372;5249.7112658804135;5298.2052692096495;3617.7286703497343;4696.506866779007;4796.232602783538;4820.132376172252;4869.172240719086;3887.4168874669026;3957.1689945111275;4017.738846974996;4028.959710402917;4062.0251139726843;1218.3481837217046;1222.7615614955175;1226.8098444740901;1230.237252903188;1238.0467040378858;791.7862177212121;923.8013827027221;936.4708939449325;946.4226821638795;978.2760757039739;5906.527477801766;6103.267607887082;6109.111904157507;6160.691965401712;6220.782272620437;431.35727765628985;451.58454222115734;452.606232577653;453.0712040317336;461.19291240329426;4001.8599349022643;4018.3972404139026;4020.6984476164403;4116.794160291974;4145.97927010363;10417.374957502423;10753.301035432673;10756.838647420294;10786.56853725858;10791.56833726642;10745.677629671123;10748.193885458622;10753.623623173151;10761.300515466626;10772.622958196425;8210.384221183434;8265.95867020661;8282.917170828214;8312.16878312176;8319.292860106958;4577.679562430598;4713.764311784328;5978.701064946822;6050.9394906050375;6225.84821807967;9755.756106097404;9928.751781205528;10024.899751002396;10031.448270345201;10092.697219083439;10006.399616023062;10143.08712215904;10276.743081423025;10279;10290.434026128634;7609.048868891388;7611.88582171279;7630.961845190961;7641.197674244125;7713.42149338813;8356.832863342821;8439.367047471587;8441.155884411755;8452.112528184452;8455.28130108923;7450.474157191884;7597.392208623407;7613.238676132342;7661.808454788675;7714.15144334134;7428.851422971618;7452.552846829208;7467.626618669154;7588.506747061423;7604.505707129019;6965.47758918073;7061.82345441368;7093.077899872984;7105.7209702254095;7110.075690160246;4997.700137991732;5029.270755740324;5109.105906466428;5169.560587350117;5191.247269146028;5066.113430149635;5086.415062267739;5223.686578805284;5242.921356179737;5284.841454756363 14:43:35 INFO - PROCESS | 6364 | |4;prototype.html;299.32950191570876;304.9893253736119;312.89361617050207;314.91182468908715;318.1949667341627;4997.6501644884875;5269.578433725297;5321.483377237488;5446.9224887938335;5636.928983493139;5451.318585176853;5545.306836645419;5554.305711786027;5570.359408668004;5575.856949325389;3902.1415288636454;4072.411759413831;4232.280512312899;4250.27745283301;4274.893127671818;3926.2712414871676;4143.896402589944;4214.641755450775;4295.484541854982;4312.2453570625175;3834.5015148030716;3915.295246855565;4159.438475805773;4183.916321673565;4197.496300443951;3469.670381313771;4186.979065104671;4210.136921930997;4214.2414365414215;4230.2174097792;3043.3456806786426;3173.873045078194;3565.983694647039;3635.8909232723063;3662.1393972416463;5070.138076527;5284.9735751320995;5309.681419114865;5317.1492561190025;5345.075772721817;4551.613112885376;4810.4467986181335;4826.251930950708;4843.975780121112;4851.078295123951;5387.548665357253;5581.804636837691;5773.740181691792;5802.274715660543;5825.533957283407;3336.7163791077787;3998.900027499307;4020.738651987641;4024.557298697141;4025.376066709665;6172.444479996821;6205.28639206488;6211.9689401552705;6261.937380626181;6282.2461304643275;3946.894869436505;4086.244044851712;4094.61101195386;4100.630943215125;4129.876103716893;3396.0491062502538;4041.6362527372676;4131.586841315904;4134.524529679065;4137.91724165521;4124.876253712393;4758.52485729425;4797.424309082862;4824.5767498588;4863.7324947128245;5335.226392173113;5632.5355407594325;5637.774489020475;5882.294124705063;5960.986632272524;1241.391718058145;1252.6242127361936;1362.2699172051637;1416.0512456654067;1419.971600567983;763.4960925788953;832.7002279179491;833.9416240863203;846.5978660136509;855.0124606079987;4503.234450143484;4511.751853648016;4513.593776560059;4534.599050711966;4538.72767633943;4454.977725111418;4647.282174260578;4713.811447542129;4979.477154898684;5006.3491746073505;3772.6038765929184;3896.941545876814;3923.7841918694744;4457.732536047847;4458.948883513555;2575.7166711661703;2580.4452042810885;2659.2421159969317;2693.7608699997827;2714.294283486308;4441.422615060022;4573.839915602938;4884.8290309838985;4896.4858689837765;5232.816851410183;4746.786394612251;4793.041391721669;5152.562032227228;5157.510036546522;5167.114003388811;4389.912201755947;4657.995592842665;4731.195696731564;4772.904541909212;5280.735963201824;4378.898128898083;4527.378097522035;4582.746250162289;4679.695819771704;5129.769160387867;3984.302747019318;4878.853634390974;4962;4975.4278258000795;5027;4535.070310586388;4828.444728856227;5137.280780690631;5149.356330458692;5171.482851714798;3182;3517.683408493248;3532.7703699259464;3545.7340699447127;3580.7493475456467;4242.618164365099;4541.955350269523;4592;4927.187014142626;5704.691279058219;4750.406199225097;4846.757662116951;5802.390748971466;5808.883822323614;5874.265716785402;5422.728863556727;5575.721213939368;5830.679312637845;5854.356020837619;5854.4730974212525;5251.083354575629;5454.91817622728;5546.585620666704;5706.343770466284;5711.659598275625;5405.945940540544;5799.797007104731;5804.65172089676;5819.185314055951;5845.678487683048;5210.609204309768;5321.707306098202;5447.564194864481;5675.290588676416;5722.113072473773 14:43:35 INFO - PROCESS | 6364 | |5;yui.html;705.9294070592938;720.2509390234156;766.2950085920955;773.3117525402392;868.8175483148539;15169.620759481018;15435.382584696627;15534.922325388385;15926.283317250736;16033.518994430171;12669.733026697326;14119.505817296396;14474.5657630271;14481.058731182466;14626.195559244237;707.9185893622222;876.9079246679103;899.9055099214586;901.3059943843236;903.2187158108255;872.5593575244493;873.4846440600045;900.5047224026791;911.1480765484293;911.2527727263647;906.8911730592338;911.9785839859367;923.422860712055;923.7136487688838;930.6044930904372;915.1854849184232;918.2791508665699;918.4810582021137;920;921.5254144115786;634.6731433311849;659.8020593821834;690.2786588015535;691.2430888177438;692.8579641173548;14775;15008.549743507712;15059.698806023927;15083.849161508464;15109.39562417502;14595.562133135916;14606.488772893004;14686.63283417923;14793.556193314218;14862.70274594513;11991.100667449977;12050.39748012596;12067.879321206763;12072.456739446747;12221.144519883612;3823;3874.2251549689895;3874.5156855393075;3899.629535194152;3923.9803800980812;112887.30669039971;113496;114362;115915;120176.99999999913;9002.36983411168;11457.255278406878;11496.442265979938;11538.538458461735;11633.76732465346;23873.52252954931;23876;23907.16324928654;23940.52118957646;23968.880155599112;8171.1828817119;8194.467359621605;8298.543580103153;8378.41351105429;8476.745697629081;4559.954400456019;4595.632349412039;4597.816087356535;4640.048789998043;4648.883777905512;3559.252556963015;3685.9078523037138;3687.8893633191046;3792.1657235408165;3978.6419222270133;700.3031983176771;706.1067749297143;709.2729951799447;718.3750137380513;727.1710250314645;567.2993852592045;617.2562062714418;675.8986152077227;677.7729460630645;696.2028477393357;9416.340856140005;9464.19554337889;9529.952350238205;9704.417734935927;9912.606368892024;665.7137430904758;666.3203532396928;667.5043581478736;678.9422899053636;679.601008440197;3715.628437156263;4715.834945776881;4753.881152971203;4760.214564596872;4777.331173635694;119040.40479797545;158608;165282;169215;170217;79466;117833;146683;147879.38783979006;149370;97789.51105244429;102793.97206027994;105163.47418263013;108680;114823.85176148299;8949.821003580022;9476.461241743174;9557;10027.899721002697;10128.34165779222;45723.62829115132;56736;59234;59998.40001599928;61985.690071549354;88484;94363;98859.01140988497;100276.49861750644;100738.99261007296;12513.124081314221;12775.744485110059;13206.141600795918;13255.403506842407;13391.129576577492;12836.486540538273;13500.25748583798;14785.778213326594;15110;15313.617159570655;13470.730585388434;13502.324883755577;13751.449942002208;13840.031197816057;14007.859921400655;13797.51708690191;13870.375833087333;13901.513447029305;13905.513307034205;13936.930315348358;11711.414429278673;13127.409266583218;13378.799318010042;14171.82288212928;14177.36201870939;9931.409614608672;11132.38771867555;11242.956381741631;11384.715382115513;11707.88292117068;9836.3606365586;10439.895601043892;11541.82687259675;11662;11711.941440292743 14:43:35 INFO - PROCESS | 6364 | __end_tp_report 14:43:35 INFO - PROCESS | 6364 | __start_cc_report 14:43:35 INFO - PROCESS | 6364 | _x_x_mozilla_cycle_collect,412 14:43:35 INFO - PROCESS | 6364 | __end_cc_report 14:43:35 INFO - PROCESS | 6364 | __startTimestamp1470692615706__endTimestamp 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | ------- Summary: start ------- 14:43:35 INFO - PROCESS | 6364 | Number of tests: 6 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | [#0] dojo.html Cycles:165 Average:5837.80 Median:6091.30 stddev:659.73 (10.8%) stddev-sans-first:633.17 14:43:35 INFO - PROCESS | 6364 | Values: 3389.3 3424.6 3446.7 3477.9 3489.5 5258.2 5862.8 5879.2 5895.9 5942.8 5856.3 5896.3 5896.8 5909.2 5916.9 5331.8 5378.2 5405.1 5456.6 5472.5 5175.8 5282.7 5337.0 5400.0 5439.3 4340.5 5353.6 5358.4 5370.8 5391.3 5354.4 5354.9 5361.8 5364.1 5370.3 4226.2 5181.7 5226.6 5302.5 5316.1 4721.7 5835.0 5872.3 5889.4 5933.0 6223.6 6289.1 6294.4 6310.2 6313.1 6187.4 6196.2 6205.3 6330.1 6335.7 5921.7 5977.3 5993.7 6024.1 6031.7 6412.4 6428.1 6470.3 6474.7 6481.7 6047.9 6173.6 6185.6 6278.0 6303.4 6311.1 6312.9 6329.0 6331.1 6332.5 5349.7 6244.9 6284.1 6310.1 6317.4 6142.8 6183.0 6192.9 6270.0 6307.3 5098.9 5099.2 5109.1 5126.9 5149.5 4537.1 4554.9 4590.9 4604.6 4636.2 5769.0 5936.0 5945.8 5955.4 5969.5 6309.6 6311.6 6313.0 6318.6 6334.8 5978.3 6045.1 6046.3 6063.3 6066.8 5473.7 5519.2 5602.1 5602.8 5604.6 4995.5 6516.4 6519.2 6521.5 6585.2 6304.8 6312.3 6325.6 6336.0 6336.6 6254.5 6398.8 6415.2 6519.7 6569.1 6249.8 6280.9 6300.0 6300.7 6345.9 6298.5 6317.7 6320.9 6329.2 6342.0 5537.5 5580.9 6148.5 6182.0 6264.8 6238.5 6262.3 6262.9 6276.4 6278.6 5994.1 6091.3 6111.3 6177.3 6197.3 6129.9 6142.6 6145.2 6262.9 6283.7 6090.5 6097.2 6103.4 6112.8 6142.6 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | [#1] ext.html Cycles:180 Average:71803.76 Median:41188.29 stddev:163689.68 (397.4%) stddev-sans-first:164061.28 14:43:35 INFO - PROCESS | 6364 | Values: 479.8 497.1 512.1 521.4 556.9 38801.4 41824.0 41901.0 41952.8 42058.0 43045.8 43092.6 43100.0 43340.9 43438.0 9399.5 9492.6 9502.7 9609.7 9633.0 9578.8 9624.5 9645.5 9658.7 9659.9 9616.9 9631.2 9653.7 9672.1 9707.1 9549.3 9628.1 9658.0 9681.5 9696.5 9536.6 9639.6 9645.5 9648.7 9658.2 40801.0 40970.6 41006.0 41168.0 41179.8 3323.9 3403.1 3415.7 3439.5 3818.6 32585.0 32981.5 33311.0 33331.5 34122.8 3233.7 3263.2 3289.3 3383.2 3387.1 486151.0 493193.5 496104.5 497269.0 497421.0 34005.0 59951.0 59959.0 59964.5 59966.8 33427.0 34986.5 35021.0 35375.0 35786.3 14451.9 14532.8 14652.9 14670.1 14713.3 12148.6 12315.0 12329.5 12434.4 12461.7 7208.3 7379.4 7764.2 7868.0 7977.9 3181.7 3236.4 3239.4 3249.9 3260.7 954.5 987.5 992.4 1098.0 1150.6 25758.9 30913.4 31175.8 31207.1 31447.8 1006.3 1029.5 1079.3 1111.0 1164.2 13621.5 14121.9 16198.2 16348.3 16352.5 705233.0 706525.0 712898.0 716460.0 717773.0 43903.0 44088.3 44226.8 44387.0 44426.3 1366.7 1391.1 1400.4 1407.5 1409.6 24184.6 28984.0 30141.0 30173.0 30598.2 43043.6 52098.5 52101.5 52263.0 52404.5 594289.0 604211.0 606572.0 608918.0 610337.0 27096.5 27195.0 27302.2 27656.7 27824.0 48664.8 49034.5 49606.3 49960.0 50185.7 41090.8 41299.6 41694.0 41739.8 41901.0 40648.8 40836.0 41196.8 42041.0 42445.9 39542.8 40013.6 40856.0 40884.6 42196.8 30342.5 30623.0 32347.5 36150.6 36331.0 26108.6 26397.5 26502.0 26637.9 26768.7 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | [#2] jquery.html Cycles:180 Average:37465.16 Median:22420.44 stddev:102661.23 (457.9%) stddev-sans-first:102911.44 14:43:35 INFO - PROCESS | 6364 | Values: 371.7 378.9 384.2 399.3 407.9 18979.8 20705.0 21216.5 21291.8 21403.8 20299.3 20302.2 20903.7 20991.4 21247.9 5960.4 6030.4 6043.2 6065.7 6177.4 4241.6 6010.4 6118.1 6479.7 6769.0 6782.4 6814.7 6814.7 6816.0 6834.0 5621.6 5940.1 5971.9 6079.0 6087.0 5263.9 5772.4 5867.0 5967.3 5969.1 13361.8 13531.0 13572.9 23093.5 24476.5 2172.3 2364.3 2518.9 2605.9 2925.3 9932.1 10203.1 10366.5 10446.3 10613.7 1667.3 1852.9 1866.3 1875.7 1886.2 107622.5 132428.3 139145.5 140154.6 157030.0 21846.3 22279.4 22373.8 22467.1 22552.1 36334.6 36370.6 36371.0 36381.3 36415.0 10791.2 10955.3 11134.5 11228.9 11229.9 7447.5 9108.5 9126.6 9178.7 9197.7 8345.5 9767.7 10053.3 10219.0 10283.9 1589.8 1673.4 1693.8 3724.3 3894.6 859.4 861.5 891.3 902.0 936.6 16314.3 20084.7 21011.0 21222.8 21355.4 906.6 919.7 952.9 960.3 1004.7 10098.2 10771.5 10972.4 11077.2 11156.9 595312.0 602277.0 616648.0 617132.0 631418.0 101714.0 126627.7 132780.3 142325.0 147402.3 895.4 968.9 1004.9 1005.4 1008.9 18993.1 19264.3 19313.5 19364.7 19428.6 57713.1 58806.8 59558.4 59573.0 60590.7 87262.6 87848.0 88467.0 89281.6 90088.5 6909.7 7116.6 7116.9 8006.0 8189.3 10531.9 10882.9 12968.6 13389.9 13671.7 11427.6 11515.4 11563.2 11603.5 11714.7 11295.7 11544.3 11632.3 11645.4 11773.2 11559.8 11568.9 11791.7 11923.6 12024.0 8229.7 8453.2 8455.0 8636.7 8656.9 10035.3 11515.5 11749.2 11874.6 11894.0 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | [#3] mootools.html Cycles:180 Average:5700.27 Median:4755.00 stddev:3215.44 (67.6%) stddev-sans-first:3209.17 14:43:35 INFO - PROCESS | 6364 | Values: 1527.7 1545.7 1714.2 1798.2 1820.9 7877.8 8346.9 8397.1 8907.7 8909.0 8515.4 8686.1 8711.4 8711.8 8712.4 2304.3 2339.4 2354.3 2354.8 2360.4 2325.7 2350.0 2364.6 2382.1 2397.2 2361.8 2363.3 2366.0 2374.0 2374.7 2329.9 2337.7 2340.1 2358.2 2359.1 2344.4 2345.8 2348.7 2353.6 2363.3 8680.0 8717.9 8850.4 8868.3 8889.2 5167.4 5310.8 5338.3 5340.2 5355.1 3397.3 3439.4 3449.3 3509.1 3512.2 1082.5 1101.1 1107.0 1112.2 1120.9 9916.4 11071.6 11586.7 11664.7 11683.6 3983.0 4007.4 4453.1 4528.3 4621.9 9856.4 9943.2 9945.9 9957.8 9968.9 5202.7 5239.2 5243.9 5249.7 5298.2 3617.7 4696.5 4796.2 4820.1 4869.2 3887.4 3957.2 4017.7 4029.0 4062.0 1218.3 1222.8 1226.8 1230.2 1238.0 791.8 923.8 936.5 946.4 978.3 5906.5 6103.3 6109.1 6160.7 6220.8 431.4 451.6 452.6 453.1 461.2 4001.9 4018.4 4020.7 4116.8 4146.0 10417.4 10753.3 10756.8 10786.6 10791.6 10745.7 10748.2 10753.6 10761.3 10772.6 8210.4 8266.0 8282.9 8312.2 8319.3 4577.7 4713.8 5978.7 6050.9 6225.8 9755.8 9928.8 10024.9 10031.4 10092.7 10006.4 10143.1 10276.7 10279.0 10290.4 7609.0 7611.9 7631.0 7641.2 7713.4 8356.8 8439.4 8441.2 8452.1 8455.3 7450.5 7597.4 7613.2 7661.8 7714.2 7428.9 7452.6 7467.6 7588.5 7604.5 6965.5 7061.8 7093.1 7105.7 7110.1 4997.7 5029.3 5109.1 5169.6 5191.2 5066.1 5086.4 5223.7 5242.9 5284.8 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | [#4] prototype.html Cycles:180 Average:4404.81 Median:4754.47 stddev:1346.14 (28.3%) stddev-sans-first:1314.18 14:43:35 INFO - PROCESS | 6364 | Values: 299.3 305.0 312.9 314.9 318.2 4997.7 5269.6 5321.5 5446.9 5636.9 5451.3 5545.3 5554.3 5570.4 5575.9 3902.1 4072.4 4232.3 4250.3 4274.9 3926.3 4143.9 4214.6 4295.5 4312.2 3834.5 3915.3 4159.4 4183.9 4197.5 3469.7 4187.0 4210.1 4214.2 4230.2 3043.3 3173.9 3566.0 3635.9 3662.1 5070.1 5285.0 5309.7 5317.1 5345.1 4551.6 4810.4 4826.3 4844.0 4851.1 5387.5 5581.8 5773.7 5802.3 5825.5 3336.7 3998.9 4020.7 4024.6 4025.4 6172.4 6205.3 6212.0 6261.9 6282.2 3946.9 4086.2 4094.6 4100.6 4129.9 3396.0 4041.6 4131.6 4134.5 4137.9 4124.9 4758.5 4797.4 4824.6 4863.7 5335.2 5632.5 5637.8 5882.3 5961.0 1241.4 1252.6 1362.3 1416.1 1420.0 763.5 832.7 833.9 846.6 855.0 4503.2 4511.8 4513.6 4534.6 4538.7 4455.0 4647.3 4713.8 4979.5 5006.3 3772.6 3896.9 3923.8 4457.7 4458.9 2575.7 2580.4 2659.2 2693.8 2714.3 4441.4 4573.8 4884.8 4896.5 5232.8 4746.8 4793.0 5152.6 5157.5 5167.1 4389.9 4658.0 4731.2 4772.9 5280.7 4378.9 4527.4 4582.7 4679.7 5129.8 3984.3 4878.9 4962.0 4975.4 5027.0 4535.1 4828.4 5137.3 5149.4 5171.5 3182.0 3517.7 3532.8 3545.7 3580.7 4242.6 4542.0 4592.0 4927.2 5704.7 4750.4 4846.8 5802.4 5808.9 5874.3 5422.7 5575.7 5830.7 5854.4 5854.5 5251.1 5454.9 5546.6 5706.3 5711.7 5405.9 5799.8 5804.7 5819.2 5845.7 5210.6 5321.7 5447.6 5675.3 5722.1 14:43:35 INFO - PROCESS | 6364 | 14:43:35 INFO - PROCESS | 6364 | [#5] yui.html Cycles:180 Average:25205.10 Median:3686.90 stddev:40782.18 (1106.1%) stddev-sans-first:40855.10 14:43:35 INFO - PROCESS | 6364 | Values: 705.9 720.3 766.3 773.3 868.8 15169.6 15435.4 15534.9 15926.3 16033.5 12669.7 14119.5 14474.6 14481.1 14626.2 707.9 876.9 899.9 901.3 903.2 872.6 873.5 900.5 911.1 911.3 906.9 912.0 923.4 923.7 930.6 915.2 918.3 918.5 920.0 921.5 634.7 659.8 690.3 691.2 692.9 14775.0 15008.5 15059.7 15083.8 15109.4 14595.6 14606.5 14686.6 14793.6 14862.7 11991.1 12050.4 12067.9 12072.5 12221.1 3823.0 3874.2 3874.5 3899.6 3924.0 112887.3 113496.0 114362.0 115915.0 120177.0 9002.4 11457.3 11496.4 11538.5 11633.8 23873.5 23876.0 23907.2 23940.5 23968.9 8171.2 8194.5 8298.5 8378.4 8476.7 4560.0 4595.6 4597.8 4640.0 4648.9 3559.3 3685.9 3687.9 3792.2 3978.6 700.3 706.1 709.3 718.4 727.2 567.3 617.3 675.9 677.8 696.2 9416.3 9464.2 9530.0 9704.4 9912.6 665.7 666.3 667.5 678.9 679.6 3715.6 4715.8 4753.9 4760.2 4777.3 119040.4 158608.0 165282.0 169215.0 170217.0 79466.0 117833.0 146683.0 147879.4 149370.0 97789.5 102794.0 105163.5 108680.0 114823.9 8949.8 9476.5 9557.0 10027.9 10128.3 45723.6 56736.0 59234.0 59998.4 61985.7 88484.0 94363.0 98859.0 100276.5 100739.0 12513.1 12775.7 13206.1 13255.4 13391.1 12836.5 13500.3 14785.8 15110.0 15313.6 13470.7 13502.3 13751.4 13840.0 14007.9 13797.5 13870.4 13901.5 13905.5 13936.9 11711.4 13127.4 13378.8 14171.8 14177.4 9931.4 11132.4 11243.0 11384.7 11707.9 9836.4 10439.9 11541.8 11662.0 11711.9 14:43:35 INFO - PROCESS | 6364 | -------- Summary: end -------- 14:43:35 INFO - PROCESS | 6364 | 14:43:36 INFO - TEST-INFO | 6364: exit 0 14:43:36 INFO - TEST-OK | dromaeo_css | took 1113771ms 14:43:36 INFO - TEST-START | kraken 14:43:36 INFO - operating with platform_type : mac_ 14:43:36 INFO - Initialising browser for kraken test... 14:43:36 INFO - TEST-INFO | started process 6369 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpKCR1_C/profile http://localhost:56936/getInfo.html) 14:43:38 INFO - PROCESS | 6369 | __metrics Screen width/height:1600/1200 14:43:38 INFO - PROCESS | 6369 | colorDepth:24 14:43:38 INFO - PROCESS | 6369 | Browser inner width/height: 1024/689 14:43:38 INFO - PROCESS | 6369 | __metrics 14:43:39 ERROR - PROCESS | 6369 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:43:39 INFO - TEST-INFO | 6369: exit 0 14:43:39 INFO - Browser initialized. 14:43:39 INFO - Running cycle 1/1 for kraken test... 14:43:39 INFO - TEST-INFO | started process 6371 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpKCR1_C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:51 INFO - PROCESS | 6371 | RSS: Main: 254595072 14:43:51 INFO - PROCESS | 6371 | 14:43:54 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:55 INFO - PROCESS | 6371 | RSS: Main: 267550720 14:43:55 INFO - PROCESS | 6371 | 14:43:58 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-dft) 14:43:59 INFO - PROCESS | 6371 | RSS: Main: 276353024 14:43:59 INFO - PROCESS | 6371 | 14:44:02 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-fft) 14:44:03 INFO - PROCESS | 6371 | RSS: Main: 279498752 14:44:03 INFO - PROCESS | 6371 | 14:44:05 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56936/tests/kraken/driver.html?testName=audio-oscillator) 14:44:05 INFO - PROCESS | 6371 | RSS: Main: 281878528 14:44:05 INFO - PROCESS | 6371 | 14:44:07 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56936/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:08 INFO - PROCESS | 6371 | RSS: Main: 282222592 14:44:08 INFO - PROCESS | 6371 | 14:44:11 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56936/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:11 INFO - PROCESS | 6371 | RSS: Main: 282296320 14:44:11 INFO - PROCESS | 6371 | 14:44:14 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56936/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:15 INFO - PROCESS | 6371 | RSS: Main: 281935872 14:44:15 INFO - PROCESS | 6371 | 14:44:18 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56936/tests/kraken/driver.html?testName=json-parse-financial) 14:44:19 INFO - PROCESS | 6371 | RSS: Main: 283181056 14:44:19 INFO - PROCESS | 6371 | 14:44:20 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56936/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:21 INFO - PROCESS | 6371 | RSS: Main: 282611712 14:44:21 INFO - PROCESS | 6371 | 14:44:23 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:24 INFO - PROCESS | 6371 | RSS: Main: 282787840 14:44:24 INFO - PROCESS | 6371 | 14:44:26 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:27 INFO - PROCESS | 6371 | RSS: Main: 283140096 14:44:27 INFO - PROCESS | 6371 | 14:44:29 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:30 INFO - PROCESS | 6371 | RSS: Main: 282869760 14:44:30 INFO - PROCESS | 6371 | 14:44:33 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:34 INFO - PROCESS | 6371 | RSS: Main: 283545600 14:44:34 INFO - PROCESS | 6371 | 14:44:35 INFO - PROCESS | 6371 | Cycle 1(1): loaded http://localhost:56936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56936/tests/kraken/driver.html?testName=ai-astar) 14:44:36 INFO - PROCESS | 6371 | RSS: Main: 284344320 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | __start_tp_report 14:44:36 INFO - PROCESS | 6371 | _x_x_mozilla_page_load 14:44:36 INFO - PROCESS | 6371 | _x_x_mozilla_page_load_details 14:44:36 INFO - PROCESS | 6371 | |i|pagename|runs| 14:44:36 INFO - PROCESS | 6371 | |0;ai-astar;109;168;151;109;170;166;134;116;116;117 14:44:36 INFO - PROCESS | 6371 | |1;audio-beat-detection;171;148;135;193;142;162;136;147;199;110 14:44:36 INFO - PROCESS | 6371 | |2;audio-dft;206;219;267;241;199;207;199;205;193;199 14:44:36 INFO - PROCESS | 6371 | |3;audio-fft;70;82;77;153;60;57;59;65;143;59 14:44:36 INFO - PROCESS | 6371 | |4;audio-oscillator;71;71;118;73;72;81;118;71;73;119 14:44:36 INFO - PROCESS | 6371 | |5;imaging-gaussian-blur;88;85;88;85;89;85;87;86;89;101 14:44:36 INFO - PROCESS | 6371 | |6;imaging-darkroom;130;95;95;96;96;95;96;95;95;95 14:44:36 INFO - PROCESS | 6371 | |7;imaging-desaturate;89;126;129;123;77;150;145;110;95;146 14:44:36 INFO - PROCESS | 6371 | |8;json-parse-financial;55;56;56;57;58;57;56;58;59;55 14:44:36 INFO - PROCESS | 6371 | |9;json-stringify-tinderbox;67;71;73;74;88;105;116;73;75;73 14:44:36 INFO - PROCESS | 6371 | |10;stanford-crypto-aes;86;84;88;87;84;88;87;89;95;102 14:44:36 INFO - PROCESS | 6371 | |11;stanford-crypto-ccm;137;135;167;139;142;137;141;138;160;156 14:44:36 INFO - PROCESS | 6371 | |12;stanford-crypto-pbkdf2;173;176;165;169;179;169;232;222;165;170 14:44:36 INFO - PROCESS | 6371 | |13;stanford-crypto-sha256-iterative;70;67;70;72;85;92;77;68;66;68 14:44:36 INFO - PROCESS | 6371 | __end_tp_report 14:44:36 INFO - PROCESS | 6371 | __start_cc_report 14:44:36 INFO - PROCESS | 6371 | _x_x_mozilla_cycle_collect,1054 14:44:36 INFO - PROCESS | 6371 | __end_cc_report 14:44:36 INFO - PROCESS | 6371 | __startTimestamp1470692676160__endTimestamp 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | ------- Summary: start ------- 14:44:36 INFO - PROCESS | 6371 | Number of tests: 14 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#0] ai-astar Cycles:10 Average:135.60 Median:142.50 stddev:25.66 (18.0%) stddev-sans-first:25.35 14:44:36 INFO - PROCESS | 6371 | Values: 109.0 168.0 151.0 109.0 170.0 166.0 134.0 116.0 116.0 117.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:155.00 stddev:27.38 (17.7%) stddev-sans-first:28.37 14:44:36 INFO - PROCESS | 6371 | Values: 171.0 148.0 135.0 193.0 142.0 162.0 136.0 147.0 199.0 110.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#2] audio-dft Cycles:10 Average:213.50 Median:206.50 stddev:23.26 (11.3%) stddev-sans-first:24.52 14:44:36 INFO - PROCESS | 6371 | Values: 206.0 219.0 267.0 241.0 199.0 207.0 199.0 205.0 193.0 199.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#3] audio-fft Cycles:10 Average:82.50 Median:62.50 stddev:35.57 (56.9%) stddev-sans-first:37.43 14:44:36 INFO - PROCESS | 6371 | Values: 70.0 82.0 77.0 153.0 60.0 57.0 59.0 65.0 143.0 59.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:71.50 stddev:22.03 (30.8%) stddev-sans-first:22.62 14:44:36 INFO - PROCESS | 6371 | Values: 71.0 71.0 118.0 73.0 72.0 81.0 118.0 71.0 73.0 119.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:87.50 stddev:4.74 (5.4%) stddev-sans-first:5.02 14:44:36 INFO - PROCESS | 6371 | Values: 88.0 85.0 88.0 85.0 89.0 85.0 87.0 86.0 89.0 101.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:95.00 stddev:10.97 (11.6%) stddev-sans-first:0.50 14:44:36 INFO - PROCESS | 6371 | Values: 130.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#7] imaging-desaturate Cycles:10 Average:119.00 Median:148.00 stddev:25.50 (17.2%) stddev-sans-first:24.63 14:44:36 INFO - PROCESS | 6371 | Values: 89.0 126.0 129.0 123.0 77.0 150.0 145.0 110.0 95.0 146.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.34 (2.3%) stddev-sans-first:1.27 14:44:36 INFO - PROCESS | 6371 | Values: 55.0 56.0 56.0 57.0 58.0 57.0 56.0 58.0 59.0 55.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#9] json-stringify-tinderbox Cycles:10 Average:81.50 Median:73.00 stddev:16.40 (22.5%) stddev-sans-first:16.53 14:44:36 INFO - PROCESS | 6371 | Values: 67.0 71.0 73.0 74.0 88.0 105.0 116.0 73.0 75.0 73.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:87.50 stddev:5.52 (6.3%) stddev-sans-first:5.74 14:44:36 INFO - PROCESS | 6371 | Values: 86.0 84.0 88.0 87.0 84.0 88.0 87.0 89.0 95.0 102.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:141.50 stddev:11.39 (8.0%) stddev-sans-first:11.69 14:44:36 INFO - PROCESS | 6371 | Values: 137.0 135.0 167.0 139.0 142.0 137.0 141.0 138.0 160.0 156.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:174.50 stddev:24.23 (13.9%) stddev-sans-first:25.49 14:44:36 INFO - PROCESS | 6371 | Values: 173.0 176.0 165.0 169.0 179.0 169.0 232.0 222.0 165.0 170.0 14:44:36 INFO - PROCESS | 6371 | 14:44:36 INFO - PROCESS | 6371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:71.00 stddev:8.64 (12.2%) stddev-sans-first:9.08 14:44:36 INFO - PROCESS | 6371 | Values: 70.0 67.0 70.0 72.0 85.0 92.0 77.0 68.0 66.0 68.0 14:44:36 INFO - PROCESS | 6371 | -------- Summary: end -------- 14:44:36 INFO - PROCESS | 6371 | 14:44:37 INFO - TEST-INFO | 6371: exit 0 14:44:37 INFO - TEST-OK | kraken | took 60725ms 14:44:37 INFO - SUITE-END | took 1174s 14:44:37 INFO - Completed test suite (00:19:34) 14:44:37 INFO - javascript benchmark 14:44:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7401.633133992994, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3389.322135572886, 3424.6232914379416, 3446.741494387921, 3477.947830782539, 3489.494023366612, 5258.237555554447, 5862.824115276538, 5879.176915231866, 5895.941040589592, 5942.76228950842, 5856.326522449919, 5896.292444906607, 5896.823095307137, 5909.172715819789, 5916.88166236675, 5331.840044798662, 5378.193271009341, 5405.081136206834, 5456.61803673743, 5472.452754724535, 5175.767090480918, 5282.656627319231, 5337.01265265927, 5399.9730001349935, 5439.265699130607, 4340.544242854487, 5353.5984801139875, 5358.356997160366, 5370.758315875756, 5391.272178255944, 5354.41101478837, 5354.929014197176, 5361.839144825662, 5364.088105022117, 5370.3287089113865, 4226.154769046172, 5181.689098654055, 5226.55574276187, 5302.496262855023, 5316.0962636351915, 4721.693089949176, 5835.0, 5872.324682661506, 5889.411058894119, 5932.9703351483395, 6223.5954662947215, 6289.119523266746, 6294.433500984887, 6310.211223597051, 6313.053042043684, 6187.3503282155625, 6196.225471816023, 6205.286392064925, 6330.113784070234, 6335.651539165344, 5921.73352199152, 5977.312609049928, 5993.700314984233, 6024.09638554216, 6031.698415079229, 6412.35876412355, 6428.099723431825, 6470.288268290485, 6474.6762661866715, 6481.740730370827, 6047.879042419215, 6173.59871608344, 6185.567010309325, 6278.0, 6303.401176888188, 6311.147995020705, 6312.905306420407, 6329.0, 6331.113644089831, 6332.461740752087, 5349.705766182898, 6244.937550624527, 6284.12022316876, 6310.0850376695125, 6317.431431171125, 6142.836439233798, 6182.969085154546, 6192.938070619326, 6269.96865015672, 6307.337729538424, 5098.923516147261, 5099.209622508517, 5109.054824857413, 5126.948730512721, 5149.48505149482, 4537.069900670354, 4554.863354099382, 4590.885227869263, 4604.631629469634, 4636.165490211794, 5769.048107062287, 5935.970320148372, 5945.791897283574, 5955.40445955401, 5969.492593129546, 6309.589876658002, 6311.558190926683, 6313.0, 6318.589291696117, 6334.778282760081, 5978.282606087298, 6045.093236014545, 6046.3349031606485, 6063.302720187146, 6066.757329706762, 5473.698946557977, 5519.227308176858, 5602.075657516546, 5602.775888964396, 5604.607677462538, 4995.450500445021, 6516.446102081376, 6519.185101862173, 6521.543491955517, 6585.242697089704, 6304.779332723333, 6312.305646378986, 6325.588836725598, 6335.968320158369, 6336.556441049267, 6254.4996400286955, 6398.776042838478, 6415.166028416276, 6519.674016299261, 6569.080328754074, 6249.78125765596, 6280.905786413116, 6300.0234963580715, 6300.653464059521, 6345.936540634534, 6298.496120310272, 6317.684115794284, 6320.905186422299, 6329.240491141092, 6342.048692695948, 5537.501624853782, 5580.939621471907, 6148.4773794227995, 6182.0, 6264.843378915563, 6238.469730072995, 6262.279837818709, 6262.906056409066, 6276.435120839146, 6278.560500764903, 5994.13085102649, 6091.299500557316, 6111.297200821962, 6177.320494745484, 6197.287311959182, 6129.908051379322, 6142.57002009855, 6145.187169784835, 6262.874742505033, 6283.654399008098, 6090.451859332681, 6097.237845269341, 6103.428585615297, 6112.780907263289, 6142.6314421134875], "value": 5797.605088696352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.81287297953793, 497.05063329041536, 512.1447183204049, 521.3951815893562, 556.9359523654781, 38801.41797873031, 41824.0, 41900.95247618811, 41952.790236048815, 42057.99999999992, 43045.7847710761, 43092.56907430925, 43100.0, 43340.91647708809, 43438.0, 9399.530023498832, 9492.572834222443, 9502.667406640734, 9609.711708648752, 9632.951835240814, 9578.760530986712, 9624.47065411402, 9645.469499177543, 9658.710238692815, 9659.903400966006, 9616.903830961706, 9631.229501639851, 9653.71038868835, 9672.129508344247, 9707.077827606367, 9549.331546791727, 9628.085331893459, 9657.951710241474, 9681.467519286436, 9696.51517424133, 9536.5695145728, 9639.614415423444, 9645.469499177543, 9648.662296819577, 9658.227341812708, 40801.0, 40970.590294096975, 41005.97485062868, 41167.97080072992, 41179.7941010293, 3323.8670453181844, 3403.149212696826, 3415.6639433850346, 3439.518467414564, 3818.618138186187, 32585.0, 32981.50527742086, 33311.000669979694, 33331.500027499605, 34122.829385852914, 3233.692799184097, 3263.216827961272, 3289.3256882339065, 3383.2218589724257, 3387.068556147079, 486151.0, 493193.53403232753, 496104.5194774003, 497269.0, 497421.0257897411, 34005.0, 59951.0, 59959.0, 59964.50088747816, 59966.800663986476, 33426.99719008385, 34986.475202871974, 35021.0, 35375.0, 35786.28427431437, 14451.85548144505, 14532.782008269884, 14652.926735366254, 14670.119792812466, 14713.264336783332, 12148.635540933787, 12314.953228975459, 12329.50681972729, 12434.440450179764, 12461.688457788629, 7208.27917208275, 7379.409647228209, 7764.184760600168, 7868.0, 7977.880331795028, 3181.729552988022, 3236.3689080629524, 3239.4330992076293, 3249.8862539810993, 3260.6739326067204, 954.5084281594984, 987.4519641598981, 992.3847214726771, 1097.9898493386104, 1150.5570355413058, 25758.871205643853, 30913.381732365226, 31175.84412077925, 31207.063788086394, 31447.84276078605, 1006.2855372685475, 1029.4801125431609, 1079.2930630437077, 1110.9833352499556, 1164.2025212729138, 13621.523246686318, 14121.858781412055, 16198.239972078924, 16348.346066157459, 16352.509424717278, 705233.0, 706525.0, 712898.0, 716460.0, 717773.0, 43903.0, 44088.338674919905, 44226.778866105466, 44387.0, 44426.333604995954, 1366.7403193393222, 1391.0818859552646, 1400.3978289335682, 1407.5284779598744, 1409.605310513058, 24184.637230441207, 28984.0, 30140.950480229512, 30173.0, 30598.235044124074, 43043.56956430396, 52098.47901520936, 52101.478985209666, 52263.0, 52404.47595524148, 594289.0, 604211.0, 606572.0, 608918.0, 610337.0, 27096.458070838078, 27195.0, 27302.180934571996, 27656.72343276622, 27824.0, 48664.75667621639, 49034.509654904425, 49606.25590616216, 49960.0, 50185.74535636638, 41090.79454602708, 41299.58700412957, 41694.0, 41739.791301043304, 41901.0, 40648.79675601603, 40836.0, 41196.79401602973, 42041.0, 42445.938851527724, 39542.802285988386, 40013.599864000986, 40856.0, 40884.59115408808, 42196.789016054725, 30342.544861827533, 30623.0, 32347.51478727868, 36150.63849361578, 36331.0, 26108.608370874834, 26397.472050559267, 26502.0, 26637.866810665822, 26768.732312676624], "value": 18860.228610790018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.67849809914435, 378.8730775190311, 384.1912773611548, 399.32314726538493, 407.8633657724662, 18979.810201897977, 20705.0, 21216.4695882603, 21291.787082129173, 21403.785962140373, 20299.289524866632, 20302.18791248348, 20903.68644470334, 20991.370258892257, 21247.893760531177, 5960.374160713128, 6030.396960303957, 6043.184170137041, 6065.696715164247, 6177.444030037295, 4241.554636763141, 6010.398960103998, 6118.1434599156155, 6479.708413121421, 6768.966155169217, 6782.423494003016, 6814.659267036654, 6814.659267036654, 6816.0, 6833.965830170867, 5621.634593751413, 5940.138679891392, 5971.910421343683, 6078.96960515199, 6086.969565152146, 5263.86840328991, 5772.365039845614, 5867.0, 5967.343592204854, 5969.134475501028, 13361.799573006412, 13531.0, 13572.93213533926, 23093.538129237488, 24476.510469790504, 2172.326578760589, 2364.3261670423844, 2518.9118380856767, 2605.8924956893243, 2925.2979284971666, 9932.106110450095, 10203.081722644924, 10366.533505992173, 10446.26876118672, 10613.681589552325, 1667.3330667732882, 1852.8888266704041, 1866.2628261836635, 1875.7186422036668, 1886.1700851625378, 107622.46188769085, 132428.33785831105, 139145.47690707783, 140154.59845401518, 157030.0, 21846.344609661737, 22279.443013924458, 22373.776262237494, 22467.10131594718, 22552.0979160835, 36334.63665363366, 36370.63629363725, 36371.0, 36381.27237455236, 36415.0, 10791.190660700478, 10955.287906286225, 11134.49894754738, 11228.943855280671, 11229.943850280697, 7447.478676492702, 9108.513659791244, 9126.58930348136, 9178.67874624385, 9197.678081267257, 8345.5409952452, 9767.658131965489, 10053.346532475513, 10219.029192226726, 10283.897161028444, 1589.8410158984009, 1673.3557580331417, 1693.796744390681, 3724.3296206682517, 3894.571597124314, 859.4315374441669, 861.4874149880811, 891.2869704236584, 901.9909800901906, 936.6487567162314, 16314.347426102822, 20084.69872951907, 21011.0, 21222.83274419922, 21355.35933921985, 906.619219927632, 919.72868003939, 952.9428234305825, 960.2510042166981, 1004.6734811186394, 10098.192144628412, 10771.461426928623, 10972.396518191417, 11077.224594278323, 11156.944215278872, 595312.0, 602277.0, 616648.0, 617132.0, 631418.0, 101714.0, 126627.73372266344, 132780.3360983189, 142325.0, 147402.26298868438, 895.3911340288666, 968.8885778135464, 1004.9346792458467, 1005.3565717940523, 1008.8638033865334, 18993.14530846143, 19264.32574859873, 19313.51716207106, 19364.70952935679, 19428.611427771648, 57713.13430298465, 58806.82386352334, 59558.40441595529, 59573.0, 60590.697046514484, 87262.56368718116, 87848.0, 88467.0, 89281.55359223162, 90088.5495572518, 6909.723611055501, 7116.64783691097, 7116.857662846611, 8006.0, 8189.344852411912, 10531.94734026325, 10882.891171088188, 12968.610941671765, 13389.866101339252, 13671.658208544866, 11427.60003399877, 11515.366654834064, 11563.248388854698, 11603.477843496894, 11714.70713232176, 11295.717607059889, 11544.307341559534, 11632.302061876315, 11645.41772911334, 11773.234739741889, 11559.768804623693, 11568.878436975863, 11791.705207369885, 11923.582674606347, 12024.0, 8229.670813167406, 8453.239208471266, 8455.0, 8636.740897773077, 8656.870146947927, 10035.34770239932, 11515.481803319039, 11749.177557570887, 11874.643760687193, 11894.048476122063], "value": 10520.624903981423, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.7250094982905, 1545.7372246718057, 1714.1600615698303, 1798.1908141336394, 1820.8907465552059, 7877.7636670899965, 8346.874796878044, 8397.118302578234, 8907.68823091192, 8908.955455222724, 8515.403921725481, 8686.087960764107, 8711.43375680582, 8711.825763484727, 8712.390132690714, 2304.2511183865267, 2339.415146213447, 2354.281944007077, 2354.788069073783, 2360.433495960974, 2325.7092863392077, 2349.9765002349927, 2364.645303204516, 2382.1424287256573, 2397.2328854766483, 2361.7520160383083, 2363.3382652857226, 2365.95268094638, 2373.9762602373926, 2374.715034195899, 2329.94175145621, 2337.731160916491, 2340.1458467659354, 2358.174638876397, 2359.1271229645054, 2344.4138965258685, 2345.812335013212, 2348.6594443805725, 2353.646952957053, 2363.2673871100014, 8680.0, 8717.912820871774, 8850.380473366868, 8868.33487488441, 8889.19997200255, 5167.4057483389515, 5310.840674779763, 5338.332708411449, 5340.198970154508, 5355.143177091647, 3397.252604427022, 3439.449688049925, 3449.258409441957, 3509.1051781795736, 3512.227309991798, 1082.4912291223113, 1101.0971003776826, 1107.020287045962, 1112.1825458288151, 1120.9215354925159, 9916.405015699009, 11071.612493562687, 11586.71033224176, 11664.650060498114, 11683.649490515298, 3982.9601703983167, 4007.35882258843, 4453.0648563801315, 4528.343390208402, 4621.861344159681, 9856.408615483095, 9943.154831839374, 9945.850812237823, 9957.80084398308, 9968.900310996798, 5202.713850738246, 5239.240310155083, 5243.868903277372, 5249.7112658804135, 5298.2052692096495, 3617.7286703497343, 4696.506866779007, 4796.232602783538, 4820.132376172252, 4869.172240719086, 3887.4168874669026, 3957.1689945111275, 4017.738846974996, 4028.959710402917, 4062.0251139726843, 1218.3481837217046, 1222.7615614955175, 1226.8098444740901, 1230.237252903188, 1238.0467040378858, 791.7862177212121, 923.8013827027221, 936.4708939449325, 946.4226821638795, 978.2760757039739, 5906.527477801766, 6103.267607887082, 6109.111904157507, 6160.691965401712, 6220.782272620437, 431.35727765628985, 451.58454222115734, 452.606232577653, 453.0712040317336, 461.19291240329426, 4001.8599349022643, 4018.3972404139026, 4020.6984476164403, 4116.794160291974, 4145.97927010363, 10417.374957502423, 10753.301035432673, 10756.838647420294, 10786.56853725858, 10791.56833726642, 10745.677629671123, 10748.193885458622, 10753.623623173151, 10761.300515466626, 10772.622958196425, 8210.384221183434, 8265.95867020661, 8282.917170828214, 8312.16878312176, 8319.292860106958, 4577.679562430598, 4713.764311784328, 5978.701064946822, 6050.9394906050375, 6225.84821807967, 9755.756106097404, 9928.751781205528, 10024.899751002396, 10031.448270345201, 10092.697219083439, 10006.399616023062, 10143.08712215904, 10276.743081423025, 10279.0, 10290.434026128634, 7609.048868891388, 7611.88582171279, 7630.961845190961, 7641.197674244125, 7713.42149338813, 8356.832863342821, 8439.367047471587, 8441.155884411755, 8452.112528184452, 8455.28130108923, 7450.474157191884, 7597.392208623407, 7613.238676132342, 7661.808454788675, 7714.15144334134, 7428.851422971618, 7452.552846829208, 7467.626618669154, 7588.506747061423, 7604.505707129019, 6965.47758918073, 7061.82345441368, 7093.077899872984, 7105.7209702254095, 7110.075690160246, 4997.700137991732, 5029.270755740324, 5109.105906466428, 5169.560587350117, 5191.247269146028, 5066.113430149635, 5086.415062267739, 5223.686578805284, 5242.921356179737, 5284.841454756363], "value": 4503.395212008711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.32950191570876, 304.9893253736119, 312.89361617050207, 314.91182468908715, 318.1949667341627, 4997.6501644884875, 5269.578433725297, 5321.483377237488, 5446.9224887938335, 5636.928983493139, 5451.318585176853, 5545.306836645419, 5554.305711786027, 5570.359408668004, 5575.856949325389, 3902.1415288636454, 4072.411759413831, 4232.280512312899, 4250.27745283301, 4274.893127671818, 3926.2712414871676, 4143.896402589944, 4214.641755450775, 4295.484541854982, 4312.2453570625175, 3834.5015148030716, 3915.295246855565, 4159.438475805773, 4183.916321673565, 4197.496300443951, 3469.670381313771, 4186.979065104671, 4210.136921930997, 4214.2414365414215, 4230.2174097792, 3043.3456806786426, 3173.873045078194, 3565.983694647039, 3635.8909232723063, 3662.1393972416463, 5070.138076527, 5284.9735751320995, 5309.681419114865, 5317.1492561190025, 5345.075772721817, 4551.613112885376, 4810.4467986181335, 4826.251930950708, 4843.975780121112, 4851.078295123951, 5387.548665357253, 5581.804636837691, 5773.740181691792, 5802.274715660543, 5825.533957283407, 3336.7163791077787, 3998.900027499307, 4020.738651987641, 4024.557298697141, 4025.376066709665, 6172.444479996821, 6205.28639206488, 6211.9689401552705, 6261.937380626181, 6282.2461304643275, 3946.894869436505, 4086.244044851712, 4094.61101195386, 4100.630943215125, 4129.876103716893, 3396.0491062502538, 4041.6362527372676, 4131.586841315904, 4134.524529679065, 4137.91724165521, 4124.876253712393, 4758.52485729425, 4797.424309082862, 4824.5767498588, 4863.7324947128245, 5335.226392173113, 5632.5355407594325, 5637.774489020475, 5882.294124705063, 5960.986632272524, 1241.391718058145, 1252.6242127361936, 1362.2699172051637, 1416.0512456654067, 1419.971600567983, 763.4960925788953, 832.7002279179491, 833.9416240863203, 846.5978660136509, 855.0124606079987, 4503.234450143484, 4511.751853648016, 4513.593776560059, 4534.599050711966, 4538.72767633943, 4454.977725111418, 4647.282174260578, 4713.811447542129, 4979.477154898684, 5006.3491746073505, 3772.6038765929184, 3896.941545876814, 3923.7841918694744, 4457.732536047847, 4458.948883513555, 2575.7166711661703, 2580.4452042810885, 2659.2421159969317, 2693.7608699997827, 2714.294283486308, 4441.422615060022, 4573.839915602938, 4884.8290309838985, 4896.4858689837765, 5232.816851410183, 4746.786394612251, 4793.041391721669, 5152.562032227228, 5157.510036546522, 5167.114003388811, 4389.912201755947, 4657.995592842665, 4731.195696731564, 4772.904541909212, 5280.735963201824, 4378.898128898083, 4527.378097522035, 4582.746250162289, 4679.695819771704, 5129.769160387867, 3984.302747019318, 4878.853634390974, 4962.0, 4975.4278258000795, 5027.0, 4535.070310586388, 4828.444728856227, 5137.280780690631, 5149.356330458692, 5171.482851714798, 3182.0, 3517.683408493248, 3532.7703699259464, 3545.7340699447127, 3580.7493475456467, 4242.618164365099, 4541.955350269523, 4592.0, 4927.187014142626, 5704.691279058219, 4750.406199225097, 4846.757662116951, 5802.390748971466, 5808.883822323614, 5874.265716785402, 5422.728863556727, 5575.721213939368, 5830.679312637845, 5854.356020837619, 5854.4730974212525, 5251.083354575629, 5454.91817622728, 5546.585620666704, 5706.343770466284, 5711.659598275625, 5405.945940540544, 5799.797007104731, 5804.65172089676, 5819.185314055951, 5845.678487683048, 5210.609204309768, 5321.707306098202, 5447.564194864481, 5675.290588676416, 5722.113072473773], "value": 3978.345911269695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.9294070592938, 720.2509390234156, 766.2950085920955, 773.3117525402392, 868.8175483148539, 15169.620759481018, 15435.382584696627, 15534.922325388385, 15926.283317250736, 16033.518994430171, 12669.733026697326, 14119.505817296396, 14474.5657630271, 14481.058731182466, 14626.195559244237, 707.9185893622222, 876.9079246679103, 899.9055099214586, 901.3059943843236, 903.2187158108255, 872.5593575244493, 873.4846440600045, 900.5047224026791, 911.1480765484293, 911.2527727263647, 906.8911730592338, 911.9785839859367, 923.422860712055, 923.7136487688838, 930.6044930904372, 915.1854849184232, 918.2791508665699, 918.4810582021137, 920.0, 921.5254144115786, 634.6731433311849, 659.8020593821834, 690.2786588015535, 691.2430888177438, 692.8579641173548, 14775.0, 15008.549743507712, 15059.698806023927, 15083.849161508464, 15109.39562417502, 14595.562133135916, 14606.488772893004, 14686.63283417923, 14793.556193314218, 14862.70274594513, 11991.100667449977, 12050.39748012596, 12067.879321206763, 12072.456739446747, 12221.144519883612, 3823.0, 3874.2251549689895, 3874.5156855393075, 3899.629535194152, 3923.9803800980812, 112887.30669039971, 113496.0, 114362.0, 115915.0, 120176.99999999913, 9002.36983411168, 11457.255278406878, 11496.442265979938, 11538.538458461735, 11633.76732465346, 23873.52252954931, 23876.0, 23907.16324928654, 23940.52118957646, 23968.880155599112, 8171.1828817119, 8194.467359621605, 8298.543580103153, 8378.41351105429, 8476.745697629081, 4559.954400456019, 4595.632349412039, 4597.816087356535, 4640.048789998043, 4648.883777905512, 3559.252556963015, 3685.9078523037138, 3687.8893633191046, 3792.1657235408165, 3978.6419222270133, 700.3031983176771, 706.1067749297143, 709.2729951799447, 718.3750137380513, 727.1710250314645, 567.2993852592045, 617.2562062714418, 675.8986152077227, 677.7729460630645, 696.2028477393357, 9416.340856140005, 9464.19554337889, 9529.952350238205, 9704.417734935927, 9912.606368892024, 665.7137430904758, 666.3203532396928, 667.5043581478736, 678.9422899053636, 679.601008440197, 3715.628437156263, 4715.834945776881, 4753.881152971203, 4760.214564596872, 4777.331173635694, 119040.40479797545, 158608.0, 165282.0, 169215.0, 170217.0, 79466.0, 117833.0, 146683.0, 147879.38783979006, 149370.0, 97789.51105244429, 102793.97206027994, 105163.47418263013, 108680.0, 114823.85176148299, 8949.821003580022, 9476.461241743174, 9557.0, 10027.899721002697, 10128.34165779222, 45723.62829115132, 56736.0, 59234.0, 59998.40001599928, 61985.690071549354, 88484.0, 94363.0, 98859.01140988497, 100276.49861750644, 100738.99261007296, 12513.124081314221, 12775.744485110059, 13206.141600795918, 13255.403506842407, 13391.129576577492, 12836.486540538273, 13500.25748583798, 14785.778213326594, 15110.0, 15313.617159570655, 13470.730585388434, 13502.324883755577, 13751.449942002208, 13840.031197816057, 14007.859921400655, 13797.51708690191, 13870.375833087333, 13901.513447029305, 13905.513307034205, 13936.930315348358, 11711.414429278673, 13127.409266583218, 13378.799318010042, 14171.82288212928, 14177.36201870939, 9931.409614608672, 11132.38771867555, 11242.956381741631, 11384.715382115513, 11707.88292117068, 9836.3606365586, 10439.895601043892, 11541.82687259675, 11662.0, 11711.941440292743], "value": 7976.978350398531, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1606.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 168.0, 151.0, 109.0, 170.0, 166.0, 134.0, 116.0, 116.0, 117.0], "value": 135.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 148.0, 135.0, 193.0, 142.0, 162.0, 136.0, 147.0, 199.0, 110.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 219.0, 267.0, 241.0, 199.0, 207.0, 199.0, 205.0, 193.0, 199.0], "value": 213.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 77.0, 153.0, 60.0, 57.0, 59.0, 65.0, 143.0, 59.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 118.0, 73.0, 72.0, 81.0, 118.0, 71.0, 73.0, 119.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 89.0, 85.0, 87.0, 86.0, 89.0, 101.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 98.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 126.0, 129.0, 123.0, 77.0, 150.0, 145.0, 110.0, 95.0, 146.0], "value": 119.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 57.0, 58.0, 57.0, 56.0, 58.0, 59.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 73.0, 74.0, 88.0, 105.0, 116.0, 73.0, 75.0, 73.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 88.0, 87.0, 84.0, 88.0, 87.0, 89.0, 95.0, 102.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 167.0, 139.0, 142.0, 137.0, 141.0, 138.0, 160.0, 156.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 165.0, 169.0, 179.0, 169.0, 232.0, 222.0, 165.0, 170.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 72.0, 85.0, 92.0, 77.0, 68.0, 66.0, 68.0], "value": 73.5, "unit": "score"}]}]} 14:44:37 INFO - Return code: 0 14:44:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:37 ERROR - # TBPL SUCCESS # 14:44:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:37 INFO - 2016-08-08 14:44:37.504 screenresolution[6376:110754] starting screenresolution argv=screenresolution get 14:44:37 INFO - 2016-08-08 14:44:37.507 screenresolution[6376:110754] Display 0: 1600x1200x32@60 14:44:37 INFO - 2016-08-08 14:44:37.513 screenresolution[6377:110757] starting screenresolution argv=screenresolution list 14:44:37 INFO - Available Modes on Display 0 14:44:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:37 INFO - Intel Iris: 14:44:37 INFO - Chipset Model: Intel Iris 14:44:37 INFO - Type: GPU 14:44:37 INFO - Bus: Built-In 14:44:37 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:37 INFO - Vendor: Intel (0x8086) 14:44:37 INFO - Device ID: 0x0a2e 14:44:37 INFO - Revision ID: 0x0009 14:44:37 INFO - Displays: 14:44:37 INFO - Display: 14:44:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:37 INFO - Display Serial Number: 1600x1200 60 14:44:37 INFO - Main Display: Yes 14:44:37 INFO - Mirror: Off 14:44:37 INFO - Online: Yes 14:44:37 INFO - Rotation: Supported 14:44:37 INFO - Return code: 0 14:44:37 INFO - Running post-action listener: _resource_record_post_action 14:44:37 INFO - [mozharness: 2016-08-08 21:44:37.749232Z] Finished run-tests step (success) 14:44:37 INFO - Running post-run listener: _resource_record_post_run 14:44:37 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1510400; Write bytes: 706708992; Read time: 18; Write time: 1940 14:44:37 INFO - TinderboxPrint: CPU usage
54.5% 14:44:37 INFO - TinderboxPrint: I/O read bytes / time
1,510,400 / 18 14:44:37 INFO - TinderboxPrint: I/O write bytes / time
706,708,992 / 1,940 14:44:37 INFO - TinderboxPrint: CPU idle
2,203.1 (45.5%) 14:44:37 INFO - TinderboxPrint: CPU system
980.3 (20.2%) 14:44:37 INFO - TinderboxPrint: CPU user
1,658.2 (34.2%) 14:44:37 INFO - TinderboxPrint: Swap in / out
409,157,632 / 0 14:44:37 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392014336; Write bytes: 386651648; Read time: 29410; Write time: 760 14:44:37 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1510400; Write bytes: 296833024; Read time: 18; Write time: 1121 14:44:38 INFO - Running post-run listener: _upload_blobber_files 14:44:38 INFO - Blob upload gear active. 14:44:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:38 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 14:44:38 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'] 14:44:38 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 14:44:38 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:39 INFO - (blobuploader) - INFO - Done attempting. 14:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:40 INFO - (blobuploader) - INFO - Done attempting. 14:44:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:42 INFO - (blobuploader) - INFO - Done attempting. 14:44:42 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:42 INFO - Return code: 0 14:44:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/155f2c2e12b2162ee43f434533e805543d9bcc55b97850125091c1d618f3b5ea7ba5e174dfef36a3ea337e63d7740e7d3b0d43d6787352433ff44248fc045432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b25c4869fa344dbae26c018840e89c8905527b81c118d48bdbf56e6d45ec6d7886ed056e4f7a7c1f737ebbd109a2f257b52430b2e35615626c5af43f8ac534c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/127fafbe19e2e6852cdb1083c05974d00628c47c81092ecbe0a9c23caec6fdfa523db0e7e970bf4fee99f4d7965c84c2480cc46502537fa1329d613b0c12a6b5"} 14:44:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:42 INFO - Contents: 14:44:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/155f2c2e12b2162ee43f434533e805543d9bcc55b97850125091c1d618f3b5ea7ba5e174dfef36a3ea337e63d7740e7d3b0d43d6787352433ff44248fc045432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b25c4869fa344dbae26c018840e89c8905527b81c118d48bdbf56e6d45ec6d7886ed056e4f7a7c1f737ebbd109a2f257b52430b2e35615626c5af43f8ac534c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/127fafbe19e2e6852cdb1083c05974d00628c47c81092ecbe0a9c23caec6fdfa523db0e7e970bf4fee99f4d7965c84c2480cc46502537fa1329d613b0c12a6b5"} 14:44:42 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:42 INFO - Copying logs to upload dir... 14:44:42 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.398389 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-08-08 14:44:43.462176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:43.465864) ========= 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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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/155f2c2e12b2162ee43f434533e805543d9bcc55b97850125091c1d618f3b5ea7ba5e174dfef36a3ea337e63d7740e7d3b0d43d6787352433ff44248fc045432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b25c4869fa344dbae26c018840e89c8905527b81c118d48bdbf56e6d45ec6d7886ed056e4f7a7c1f737ebbd109a2f257b52430b2e35615626c5af43f8ac534c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/127fafbe19e2e6852cdb1083c05974d00628c47c81092ecbe0a9c23caec6fdfa523db0e7e970bf4fee99f4d7965c84c2480cc46502537fa1329d613b0c12a6b5"} build_url:https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/IVv-EDyrQk67aye2FyYuVQ/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/155f2c2e12b2162ee43f434533e805543d9bcc55b97850125091c1d618f3b5ea7ba5e174dfef36a3ea337e63d7740e7d3b0d43d6787352433ff44248fc045432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b25c4869fa344dbae26c018840e89c8905527b81c118d48bdbf56e6d45ec6d7886ed056e4f7a7c1f737ebbd109a2f257b52430b2e35615626c5af43f8ac534c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/127fafbe19e2e6852cdb1083c05974d00628c47c81092ecbe0a9c23caec6fdfa523db0e7e970bf4fee99f4d7965c84c2480cc46502537fa1329d613b0c12a6b5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:43.502931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:43.503242) ========= 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.UWgijSv8JU/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.p3OkZ8bYWO/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.005092 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:44:43.551172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:44:43.551837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:44:43.552121) ========= ========= Total master_lag: 0.67 =========