builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0013 starttime: 1471026203.57 results: success (0) buildid: 20160812084517 builduid: aab789c07fdc49629985afb1d396da7d revision: e8234e96da519dce5980f851c46648cdde83aab6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.570057) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.570920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.571536) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.597774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.598439) ========= 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.KpH0w497eZ/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.NftA0a1EZp/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-12 11:23:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.0M=0.001s 2016-08-12 11:23:23 (15.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112681 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.735216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.735608) ========= 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.KpH0w497eZ/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.NftA0a1EZp/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.030924 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.788201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:23.788638) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e8234e96da519dce5980f851c46648cdde83aab6 --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 e8234e96da519dce5980f851c46648cdde83aab6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KpH0w497eZ/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.NftA0a1EZp/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-12 11:23:23,864 truncating revision to first 12 chars 2016-08-12 11:23:23,864 Setting DEBUG logging. 2016-08-12 11:23:23,864 attempt 1/10 2016-08-12 11:23:23,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e8234e96da51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 11:23:24,174 unpacking tar archive at: autoland-e8234e96da51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577902 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:24.389115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:24.389472) ========= script_repo_revision: e8234e96da519dce5980f851c46648cdde83aab6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:24.389923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:24.390251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 11:23:24.409156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-12 11:23:24.409769) ========= /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.KpH0w497eZ/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.NftA0a1EZp/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:23:24 INFO - MultiFileLogger online at 20160812 11:23:24 in /builds/slave/test 11:23:24 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 11:23:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:24 INFO - {'append_to_log': False, 11:23:24 INFO - 'base_work_dir': '/builds/slave/test', 11:23:24 INFO - 'blob_upload_branch': 'Autoland', 11:23:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:24 INFO - 'branch': 'Autoland', 11:23:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:24 INFO - 'config_files': ('talos/mac_config.py',), 11:23:24 INFO - 'default_actions': ('clobber', 11:23:24 INFO - 'read-buildbot-config', 11:23:24 INFO - 'download-and-extract', 11:23:24 INFO - 'populate-webroot', 11:23:24 INFO - 'create-virtualenv', 11:23:24 INFO - 'install', 11:23:24 INFO - 'run-tests'), 11:23:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:24 INFO - 'download_minidump_stackwalk': True, 11:23:24 INFO - 'download_symbols': 'ondemand', 11:23:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:24 INFO - 'installer_path': 'installer.exe', 11:23:24 INFO - 'log_level': 'info', 11:23:24 INFO - 'log_name': 'talos', 11:23:24 INFO - 'log_to_console': True, 11:23:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:23:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:23:24 INFO - 'opt_config_files': (), 11:23:24 INFO - 'pip_index': False, 11:23:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:24 INFO - 'cmd': ('bash', 11:23:24 INFO - '-c', 11:23:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:24 INFO - 'enabled': True, 11:23:24 INFO - 'halt_on_failure': False, 11:23:24 INFO - 'name': 'check_screen_resolution'},), 11:23:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:24 INFO - 'cmd': ('bash', 11:23:24 INFO - '-c', 11:23:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:24 INFO - 'enabled': True, 11:23:24 INFO - 'halt_on_failure': False, 11:23:24 INFO - 'name': 'check_screen_resolution'},), 11:23:24 INFO - 'run_cmd_checks_enabled': True, 11:23:24 INFO - 'sps_profile': False, 11:23:24 INFO - 'sps_profile_interval': 0, 11:23:24 INFO - 'suite': 'dromaeojs-e10s', 11:23:24 INFO - 'system_bits': '32', 11:23:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:24 INFO - 'title': 't-yosemite-r7-0013', 11:23:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:24 INFO - 'use_talos_json': True, 11:23:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:24 INFO - 'work_dir': 'build'} 11:23:24 INFO - [mozharness: 2016-08-12 18:23:24.610875Z] Running clobber step. 11:23:24 INFO - Running pre-action listener: _resource_record_pre_action 11:23:24 INFO - Running main action method: clobber 11:23:24 INFO - rmtree: /builds/slave/test/build 11:23:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:26 INFO - Running post-action listener: _resource_record_post_action 11:23:26 INFO - [mozharness: 2016-08-12 18:23:26.752019Z] Finished clobber step (success) 11:23:26 INFO - [mozharness: 2016-08-12 18:23:26.752192Z] Running read-buildbot-config step. 11:23:26 INFO - Running pre-action listener: _resource_record_pre_action 11:23:26 INFO - Running main action method: read_buildbot_config 11:23:26 INFO - Using buildbot properties: 11:23:26 INFO - { 11:23:26 INFO - "project": "", 11:23:26 INFO - "product": "firefox", 11:23:26 INFO - "script_repo_revision": "production", 11:23:26 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 11:23:26 INFO - "repository": "", 11:23:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 11:23:26 INFO - "buildid": "20160812084517", 11:23:26 INFO - "pgo_build": "False", 11:23:26 INFO - "basedir": "/builds/slave/test", 11:23:26 INFO - "buildnumber": 75, 11:23:26 INFO - "slavename": "t-yosemite-r7-0013", 11:23:26 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:23:26 INFO - "platform": "yosemite_r7", 11:23:26 INFO - "scheduler": "tests-autoland-macosx64-talos", 11:23:26 INFO - "branch": "autoland", 11:23:26 INFO - "repo_path": "integration/autoland", 11:23:26 INFO - "revision": "e8234e96da519dce5980f851c46648cdde83aab6", 11:23:26 INFO - "stage_platform": "macosx64", 11:23:26 INFO - "builduid": "aab789c07fdc49629985afb1d396da7d", 11:23:26 INFO - "slavebuilddir": "test" 11:23:26 INFO - } 11:23:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:23:26 INFO - Running post-action listener: _resource_record_post_action 11:23:26 INFO - [mozharness: 2016-08-12 18:23:26.757988Z] Finished read-buildbot-config step (success) 11:23:26 INFO - [mozharness: 2016-08-12 18:23:26.758218Z] Running download-and-extract step. 11:23:26 INFO - Running pre-action listener: _resource_record_pre_action 11:23:26 INFO - Running main action method: download_and_extract 11:23:26 INFO - mkdir: /builds/slave/test/build/tests 11:23: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')]} 11:23:26 INFO - trying https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:23:26 INFO - Downloading https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:28 INFO - Downloaded 1199 bytes. 11:23:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:23:28 INFO - Using the following test package requirements: 11:23:28 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:23:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:23:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:23:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'jsshell-mac.zip'], 11:23:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:23:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:23:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:23:28 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:23:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:23:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:23:28 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:23:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:28 INFO - trying https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:23:28 INFO - Downloading https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:29 INFO - Downloaded 16328770 bytes. 11:23:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:23:35 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 11:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:35 INFO - trying https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:23:35 INFO - Downloading https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:36 INFO - Downloaded 16328770 bytes. 11:23:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:43 INFO - trying https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:23:43 INFO - Downloading https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:44 INFO - Downloaded 14413719 bytes. 11:23:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:23:45 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')]} 11:23:45 INFO - trying https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:23:45 INFO - Downloading https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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 11:23:48 INFO - Downloaded 110967443 bytes. 11:23:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:23:48 INFO - mkdir: /builds/slave/test/properties 11:23:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:23:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:23:48 INFO - Contents: 11:23:48 INFO - build_url:https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:23:48 INFO - Running post-action listener: _resource_record_post_action 11:23:48 INFO - Running post-action listener: set_extra_try_arguments 11:23:48 INFO - [mozharness: 2016-08-12 18:23:48.669755Z] Finished download-and-extract step (success) 11:23:48 INFO - [mozharness: 2016-08-12 18:23:48.669895Z] Running populate-webroot step. 11:23:48 INFO - Running pre-action listener: _resource_record_pre_action 11:23:48 INFO - Running main action method: populate_webroot 11:23:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:23:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:23:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:23:48 INFO - '--tppagecycles', 11:23:48 INFO - '7'], 11:23:48 INFO - 'tests': ['tsvgm']}}, 11:23:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:23:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:23:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:23:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:23:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['damp', 'tps']}, 11:23:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'tests': ['damp', 'tps']}, 11:23:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['dromaeo_dom']}, 11:23:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:23:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['basic_compositor_video']}, 11:23:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:23:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['a11yr', 11:23:48 INFO - 'ts_paint', 11:23:48 INFO - 'tpaint', 11:23:48 INFO - 'sessionrestore', 11:23:48 INFO - 'sessionrestore_no_auto_restore', 11:23:48 INFO - 'tabpaint']}, 11:23:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:23:48 INFO - 'ts_paint', 11:23:48 INFO - 'tpaint', 11:23:48 INFO - 'sessionrestore', 11:23:48 INFO - 'sessionrestore_no_auto_restore', 11:23:48 INFO - 'tabpaint']}, 11:23:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:23:48 INFO - 'ts_paint', 11:23:48 INFO - 'tpaint', 11:23:48 INFO - 'sessionrestore', 11:23:48 INFO - 'sessionrestore_no_auto_restore', 11:23:48 INFO - 'tabpaint']}, 11:23:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:23:48 INFO - 'ts_paint', 11:23:48 INFO - 'tpaint', 11:23:48 INFO - 'sessionrestore', 11:23:48 INFO - 'sessionrestore_no_auto_restore', 11:23:48 INFO - 'tabpaint']}, 11:23:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['a11yr', 11:23:48 INFO - 'ts_paint', 11:23:48 INFO - 'tpaint', 11:23:48 INFO - 'sessionrestore', 11:23:48 INFO - 'sessionrestore_no_auto_restore', 11:23:48 INFO - 'tabpaint']}, 11:23:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['a11yr', 11:23:48 INFO - 'ts_paint', 11:23:48 INFO - 'tpaint', 11:23:48 INFO - 'sessionrestore', 11:23:48 INFO - 'sessionrestore_no_auto_restore', 11:23:48 INFO - 'tabpaint']}, 11:23:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['tsvgx', 11:23:48 INFO - 'tsvgr_opacity', 11:23:48 INFO - 'tart', 11:23:48 INFO - 'tscrollx', 11:23:48 INFO - 'cart']}, 11:23:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:23:48 INFO - 'tsvgr_opacity', 11:23:48 INFO - 'tart', 11:23:48 INFO - 'tscrollx', 11:23:48 INFO - 'cart']}, 11:23:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'talos_options': ['--disable-e10s'], 11:23:48 INFO - 'tests': ['tp5o']}, 11:23:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'tests': ['tp5o']}, 11:23:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'talos_options': ['--disable-e10s', 11:23:48 INFO - '--xperf_path', 11:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:48 INFO - 'tests': ['tp5n']}, 11:23:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:48 INFO - 'talos_options': ['--xperf_path', 11:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:48 INFO - 'tests': ['tp5n']}}, 11:23:48 INFO - 'talos.zip': {'path': '', 11:23:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:23:48 INFO - Running post-action listener: _resource_record_post_action 11:23:48 INFO - [mozharness: 2016-08-12 18:23:48.688339Z] Finished populate-webroot step (success) 11:23:48 INFO - [mozharness: 2016-08-12 18:23:48.688469Z] Running create-virtualenv step. 11:23:48 INFO - Running pre-action listener: _resource_record_pre_action 11:23:48 INFO - Running main action method: create_virtualenv 11:23:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:23:48 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 11:23:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:23:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:23:48 INFO - Using real prefix '/tools/python27' 11:23:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:23:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:23:52 INFO - Installing pip.................done. 11:23:52 INFO - Return code: 0 11:23:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:23:52 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')]} 11:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:52 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')]} 11:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:52 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:23:52 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 11:23:52 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 11:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:52 INFO - 'HOME': '/Users/cltbld', 11:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:52 INFO - 'LOGNAME': 'cltbld', 11:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:52 INFO - 'MOZ_NO_REMOTE': '1', 11:23:52 INFO - 'NO_EM_RESTART': '1', 11:23:52 INFO - 'PAGER': '/bin/cat', 11:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:52 INFO - 'PWD': '/builds/slave/test', 11:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:52 INFO - 'SHELL': '/bin/bash', 11:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:23:52 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:52 INFO - 'USER': 'cltbld', 11:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:52 INFO - 'XPC_FLAGS': '0x0', 11:23:52 INFO - 'XPC_SERVICE_NAME': '0', 11:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:52 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 11:23:52 INFO - Cleaning up... 11:23:52 INFO - Return code: 0 11:23:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:23:52 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')]} 11:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:52 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')]} 11:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:52 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:23:52 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 11:23:52 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 11:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:52 INFO - 'HOME': '/Users/cltbld', 11:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:52 INFO - 'LOGNAME': 'cltbld', 11:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:52 INFO - 'MOZ_NO_REMOTE': '1', 11:23:52 INFO - 'NO_EM_RESTART': '1', 11:23:52 INFO - 'PAGER': '/bin/cat', 11:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:52 INFO - 'PWD': '/builds/slave/test', 11:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:52 INFO - 'SHELL': '/bin/bash', 11:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:23:52 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:52 INFO - 'USER': 'cltbld', 11:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:52 INFO - 'XPC_FLAGS': '0x0', 11:23:52 INFO - 'XPC_SERVICE_NAME': '0', 11:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:52 INFO - Downloading/unpacking psutil>=3.1.1 11:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:23:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:55 INFO - Installing collected packages: psutil 11:23:55 INFO - Running setup.py install for psutil 11:23:55 INFO - building 'psutil._psutil_osx' extension 11:23:55 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 11:23:56 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 11:23:56 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 11:23:56 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 11:23:56 INFO - building 'psutil._psutil_posix' extension 11:23:56 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 11:23:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:23:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:23:56 INFO - ^ 11:23:56 INFO - 1 warning generated. 11:23:56 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 11:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:57 INFO - Successfully installed psutil 11:23:57 INFO - Cleaning up... 11:23:57 INFO - Return code: 0 11:23:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:57 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:23:57 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 11:23:57 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 11:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:57 INFO - 'HOME': '/Users/cltbld', 11:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:57 INFO - 'LOGNAME': 'cltbld', 11:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:57 INFO - 'MOZ_NO_REMOTE': '1', 11:23:57 INFO - 'NO_EM_RESTART': '1', 11:23:57 INFO - 'PAGER': '/bin/cat', 11:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:57 INFO - 'PWD': '/builds/slave/test', 11:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:57 INFO - 'SHELL': '/bin/bash', 11:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:23:57 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:57 INFO - 'USER': 'cltbld', 11:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:57 INFO - 'XPC_FLAGS': '0x0', 11:23:57 INFO - 'XPC_SERVICE_NAME': '0', 11:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:23:57 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 11:23:57 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 11:23:57 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 11:23:57 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 11:23:57 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 11:23:57 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 11:23:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:23:59 INFO - Installing collected packages: mozsystemmonitor 11:23:59 INFO - Running setup.py install for mozsystemmonitor 11:23:59 INFO - Successfully installed mozsystemmonitor 11:23:59 INFO - Cleaning up... 11:24:00 INFO - Return code: 0 11:24:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11: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')]} 11:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', '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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11: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 jsonschema==2.5.1 11:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:00 INFO - 'HOME': '/Users/cltbld', 11:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:00 INFO - 'LOGNAME': 'cltbld', 11:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:00 INFO - 'MOZ_NO_REMOTE': '1', 11:24:00 INFO - 'NO_EM_RESTART': '1', 11:24:00 INFO - 'PAGER': '/bin/cat', 11:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:00 INFO - 'PWD': '/builds/slave/test', 11:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:00 INFO - 'SHELL': '/bin/bash', 11:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:00 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:00 INFO - 'USER': 'cltbld', 11:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:00 INFO - 'XPC_FLAGS': '0x0', 11:24:00 INFO - 'XPC_SERVICE_NAME': '0', 11:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:00 INFO - Downloading/unpacking jsonschema==2.5.1 11: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 11: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 11: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 11: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 11: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 11: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 11:24:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:02 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 11:24:02 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 11:24:02 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 11:24:02 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 11:24:02 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 11:24:02 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 11:24:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:03 INFO - warning: no files found matching '*.txt' 11:24:03 INFO - no previously-included directories found matching 'build' 11:24:03 INFO - no previously-included directories found matching 'dist' 11:24:03 INFO - no previously-included directories found matching '.git*' 11:24:03 INFO - Installing collected packages: jsonschema, functools32 11:24:03 INFO - Running setup.py install for functools32 11:24:03 INFO - warning: no files found matching '*.txt' 11:24:03 INFO - no previously-included directories found matching 'build' 11:24:03 INFO - no previously-included directories found matching 'dist' 11:24:03 INFO - no previously-included directories found matching '.git*' 11:24:03 INFO - Successfully installed jsonschema functools32 11:24:03 INFO - Cleaning up... 11:24:03 INFO - Return code: 0 11:24:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:03 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:24:03 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 11:24:03 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 11:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:03 INFO - 'HOME': '/Users/cltbld', 11:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:03 INFO - 'LOGNAME': 'cltbld', 11:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:03 INFO - 'MOZ_NO_REMOTE': '1', 11:24:03 INFO - 'NO_EM_RESTART': '1', 11:24:03 INFO - 'PAGER': '/bin/cat', 11:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:03 INFO - 'PWD': '/builds/slave/test', 11:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:03 INFO - 'SHELL': '/bin/bash', 11:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:03 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:03 INFO - 'USER': 'cltbld', 11:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:03 INFO - 'XPC_FLAGS': '0x0', 11:24:03 INFO - 'XPC_SERVICE_NAME': '0', 11:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:03 INFO - Cleaning up... 11:24:03 INFO - Return code: 0 11:24:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:03 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:24:03 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 11:24:03 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 11:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:03 INFO - 'HOME': '/Users/cltbld', 11:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:03 INFO - 'LOGNAME': 'cltbld', 11:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:03 INFO - 'MOZ_NO_REMOTE': '1', 11:24:03 INFO - 'NO_EM_RESTART': '1', 11:24:03 INFO - 'PAGER': '/bin/cat', 11:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:03 INFO - 'PWD': '/builds/slave/test', 11:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:03 INFO - 'SHELL': '/bin/bash', 11:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:03 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:03 INFO - 'USER': 'cltbld', 11:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:03 INFO - 'XPC_FLAGS': '0x0', 11:24:03 INFO - 'XPC_SERVICE_NAME': '0', 11:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:03 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 11:24:03 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 11:24:03 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 11:24:03 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 11:24:03 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 11:24:03 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 11:24:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:06 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 11:24:06 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 11:24:06 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 11:24:06 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 11:24:06 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 11:24:06 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 11:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:07 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 11:24:07 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 11:24:07 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 11:24:07 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 11:24:07 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 11:24:07 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 11:24:07 INFO - Downloading docopt-0.6.1.tar.gz 11:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:07 INFO - Running setup.py install for blobuploader 11:24:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:07 INFO - Running setup.py install for requests 11:24:08 INFO - Running setup.py install for docopt 11:24:08 INFO - Successfully installed blobuploader requests docopt 11:24:08 INFO - Cleaning up... 11:24:08 INFO - Return code: 0 11:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11: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')]} 11:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:08 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:24:08 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 11:24:08 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 11:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:08 INFO - 'HOME': '/Users/cltbld', 11:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:08 INFO - 'LOGNAME': 'cltbld', 11:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:08 INFO - 'MOZ_NO_REMOTE': '1', 11:24:08 INFO - 'NO_EM_RESTART': '1', 11:24:08 INFO - 'PAGER': '/bin/cat', 11:24:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:08 INFO - 'PWD': '/builds/slave/test', 11:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:08 INFO - 'SHELL': '/bin/bash', 11:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:08 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:08 INFO - 'USER': 'cltbld', 11:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:08 INFO - 'XPC_FLAGS': '0x0', 11:24:08 INFO - 'XPC_SERVICE_NAME': '0', 11:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-k77zYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:08 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-6Jgst5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-r45Okv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-eRBBUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-VnKkLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vOBAM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Mc9ZBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-LQ3AIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-OswoJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-5xjO7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:09 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ZWrYSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:10 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mZX_A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:10 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ymBTcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:10 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nBlj8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:10 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ZcrBnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:10 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-oQt3Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:10 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AUyflk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:10 INFO - Running setup.py install for manifestparser 11:24:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Running setup.py install for mozcrash 11:24:10 INFO - Running setup.py install for mozdebug 11:24:11 INFO - Running setup.py install for mozdevice 11:24:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Running setup.py install for mozfile 11:24:11 INFO - Running setup.py install for mozhttpd 11:24:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Running setup.py install for mozinfo 11:24:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Running setup.py install for mozInstall 11:24:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Running setup.py install for mozleak 11:24:11 INFO - Running setup.py install for mozlog 11:24:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:12 INFO - Running setup.py install for moznetwork 11:24:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:12 INFO - Running setup.py install for mozprocess 11:24:12 INFO - Running setup.py install for mozprofile 11:24:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:12 INFO - Running setup.py install for mozrunner 11:24:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:12 INFO - Running setup.py install for mozscreenshot 11:24:12 INFO - Running setup.py install for moztest 11:24:13 INFO - Running setup.py install for mozversion 11:24:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:13 INFO - Cleaning up... 11:24:13 INFO - Return code: 0 11:24:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:13 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')]} 11:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:13 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')]} 11:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:13 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:24:13 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 11:24:13 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 11:24:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:13 INFO - 'HOME': '/Users/cltbld', 11:24:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:13 INFO - 'LOGNAME': 'cltbld', 11:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:13 INFO - 'MOZ_NO_REMOTE': '1', 11:24:13 INFO - 'NO_EM_RESTART': '1', 11:24:13 INFO - 'PAGER': '/bin/cat', 11:24:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:13 INFO - 'PWD': '/builds/slave/test', 11:24:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:13 INFO - 'SHELL': '/bin/bash', 11:24:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:13 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:13 INFO - 'USER': 'cltbld', 11:24:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:13 INFO - 'XPC_FLAGS': '0x0', 11:24:13 INFO - 'XPC_SERVICE_NAME': '0', 11:24:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-HbjXVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-jQsKE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-0mX1Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-o9WCSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-NN_NI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-q1BcP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-cFMMnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ux3JGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-lriSxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-60rVD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pM51Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-pg0ZFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mge1Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:14 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)) 11:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:14 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-NK0l0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:15 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)) 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:15 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Gb2CR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:15 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)) 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:15 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-gJstAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:15 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)) 11:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:15 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-_qmmnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11: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 11: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 11: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 11: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 11: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 11: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 11:24:17 INFO - Downloading blessings-1.6.tar.gz 11:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:17 INFO - Installing collected packages: blessings 11:24:17 INFO - Running setup.py install for blessings 11:24:17 INFO - Successfully installed blessings 11:24:17 INFO - Cleaning up... 11:24:18 INFO - Return code: 0 11:24:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:18 INFO - Reading from file tmpfile_stdout 11:24:18 INFO - Current package versions: 11:24:18 INFO - blessings == 1.6 11:24:18 INFO - blobuploader == 1.2.4 11:24:18 INFO - docopt == 0.6.1 11:24:18 INFO - functools32 == 3.2.3-2 11:24:18 INFO - jsonschema == 2.5.1 11:24:18 INFO - manifestparser == 1.1 11:24:18 INFO - mozInstall == 1.12 11:24:18 INFO - mozcrash == 0.17 11:24:18 INFO - mozdebug == 0.1 11:24:18 INFO - mozdevice == 0.48 11:24:18 INFO - mozfile == 1.2 11:24:18 INFO - mozhttpd == 0.7 11:24:18 INFO - mozinfo == 0.9 11:24:18 INFO - mozleak == 0.1 11:24:18 INFO - mozlog == 3.3 11:24:18 INFO - moznetwork == 0.27 11:24:18 INFO - mozprocess == 0.23 11:24:18 INFO - mozprofile == 0.28 11:24:18 INFO - mozrunner == 6.12 11:24:18 INFO - mozscreenshot == 0.1 11:24:18 INFO - mozsystemmonitor == 0.3 11:24:18 INFO - moztest == 0.7 11:24:18 INFO - mozversion == 1.4 11:24:18 INFO - psutil == 3.1.1 11:24:18 INFO - requests == 1.2.3 11:24:18 INFO - wsgiref == 0.1.2 11:24:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:18 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:24:18 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 11:24:18 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 11:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:18 INFO - 'HOME': '/Users/cltbld', 11:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:18 INFO - 'LOGNAME': 'cltbld', 11:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:18 INFO - 'MOZ_NO_REMOTE': '1', 11:24:18 INFO - 'NO_EM_RESTART': '1', 11:24:18 INFO - 'PAGER': '/bin/cat', 11:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:18 INFO - 'PWD': '/builds/slave/test', 11:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:18 INFO - 'SHELL': '/bin/bash', 11:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:18 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:18 INFO - 'USER': 'cltbld', 11:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:18 INFO - 'XPC_FLAGS': '0x0', 11:24:18 INFO - 'XPC_SERVICE_NAME': '0', 11:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 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)) 11:24:18 INFO - Cleaning up... 11:24:18 INFO - Return code: 0 11:24:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:18 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 0x100caaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d3f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d3b57fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, '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.KpH0w497eZ/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.NftA0a1EZp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 11:24:18 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 11:24:18 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 11:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:18 INFO - 'HOME': '/Users/cltbld', 11:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:18 INFO - 'LOGNAME': 'cltbld', 11:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:18 INFO - 'MOZ_NO_REMOTE': '1', 11:24:18 INFO - 'NO_EM_RESTART': '1', 11:24:18 INFO - 'PAGER': '/bin/cat', 11:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:18 INFO - 'PWD': '/builds/slave/test', 11:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:18 INFO - 'SHELL': '/bin/bash', 11:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:18 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:18 INFO - 'USER': 'cltbld', 11:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:18 INFO - 'XPC_FLAGS': '0x0', 11:24:18 INFO - 'XPC_SERVICE_NAME': '0', 11:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:18 INFO - Cleaning up... 11:24:18 INFO - Return code: 0 11:24:18 INFO - Running post-action listener: _resource_record_post_action 11:24:18 INFO - Running post-action listener: _start_resource_monitoring 11:24:18 INFO - Starting resource monitoring. 11:24:18 INFO - [mozharness: 2016-08-12 18:24:18.916594Z] Finished create-virtualenv step (success) 11:24:18 INFO - [mozharness: 2016-08-12 18:24:18.917543Z] Running install step. 11:24:18 INFO - Running pre-action listener: _resource_record_pre_action 11:24:18 INFO - Running main action method: install 11:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:19 INFO - Reading from file tmpfile_stdout 11:24:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:19 INFO - Reading from file tmpfile_stdout 11:24:19 INFO - Output received: 11:24:19 INFO - Usage: mozinstall [options] installer 11:24:19 INFO - Options: 11:24:19 INFO - -h, --help show this help message and exit 11:24:19 INFO - -d DEST, --destination=DEST 11:24:19 INFO - Directory to install application into. [default: 11:24:19 INFO - "/builds/slave/test"] 11:24:19 INFO - --app=APP Application being installed. [default: firefox] 11:24:19 INFO - mkdir: /builds/slave/test/build/application 11:24:19 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'] 11:24:19 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 11:24:53 INFO - Reading from file tmpfile_stdout 11:24:53 INFO - Output received: 11:24:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:24:53 INFO - Running post-action listener: _resource_record_post_action 11:24:53 INFO - [mozharness: 2016-08-12 18:24:53.444535Z] Finished install step (success) 11:24:53 INFO - [mozharness: 2016-08-12 18:24:53.444685Z] Running run-tests step. 11:24:53 INFO - Running pre-action listener: _resource_record_pre_action 11:24:53 INFO - Running main action method: run_tests 11:24:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:24:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:24:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:24:53 INFO - 2016-08-12 11:24:53.459 screenresolution[1668:7654] starting screenresolution argv=screenresolution get 11:24:53 INFO - 2016-08-12 11:24:53.461 screenresolution[1668:7654] Display 0: 1600x1200x32@60 11:24:53 INFO - 2016-08-12 11:24:53.467 screenresolution[1669:7656] starting screenresolution argv=screenresolution list 11:24:53 INFO - Available Modes on Display 0 11:24:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:24:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:24:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:24:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:24:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:24:53 INFO - Intel Iris: 11:24:53 INFO - Chipset Model: Intel Iris 11:24:53 INFO - Type: GPU 11:24:53 INFO - Bus: Built-In 11:24:53 INFO - VRAM (Dynamic, Max): 1536 MB 11:24:53 INFO - Vendor: Intel (0x8086) 11:24:53 INFO - Device ID: 0x0a2e 11:24:53 INFO - Revision ID: 0x0009 11:24:53 INFO - Displays: 11:24:53 INFO - Display: 11:24:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:24:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:24:53 INFO - Display Serial Number: 1600x1200 60 11:24:53 INFO - Main Display: Yes 11:24:53 INFO - Mirror: Off 11:24:53 INFO - Online: Yes 11:24:53 INFO - Rotation: Supported 11:24:53 INFO - Return code: 0 11:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:53 INFO - Python 2.7.3 11:24:53 INFO - Return code: 0 11:24:53 INFO - grabbing minidump binary from tooltool 11:24:53 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')]} 11:24:53 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 0x100c0ed30>, '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 0x100973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c06b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:53 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 11:24:53 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 11:24:53 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 11:24:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:53 INFO - Return code: 0 11:24:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:24:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:24:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:53 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/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 11:24:53 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/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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 11:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KpH0w497eZ/Render', 11:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:53 INFO - 'HOME': '/Users/cltbld', 11:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:53 INFO - 'LOGNAME': 'cltbld', 11:24:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:53 INFO - 'MOZ_NO_REMOTE': '1', 11:24:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:53 INFO - 'NO_EM_RESTART': '1', 11:24:53 INFO - 'PAGER': '/bin/cat', 11:24:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:53 INFO - 'PWD': '/builds/slave/test', 11:24:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:53 INFO - 'SHELL': '/bin/bash', 11:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NftA0a1EZp/Listeners', 11:24:53 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 11:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:53 INFO - 'USER': 'cltbld', 11:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:53 INFO - 'XPC_FLAGS': '0x0', 11:24:53 INFO - 'XPC_SERVICE_NAME': '0', 11:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:53 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/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 11:24:54 INFO - mozversion application_buildid: 20160812084517 11:24:54 INFO - mozversion application_changeset: e8234e96da519dce5980f851c46648cdde83aab6 11:24:54 INFO - mozversion application_display_name: Nightly 11:24:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:54 INFO - mozversion application_name: Firefox 11:24:54 INFO - mozversion application_remotingname: firefox 11:24:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:24:54 INFO - mozversion application_vendor: Mozilla 11:24:54 INFO - mozversion application_version: 51.0a1 11:24:54 INFO - mozversion platform_buildid: 20160812084517 11:24:54 INFO - mozversion platform_changeset: e8234e96da519dce5980f851c46648cdde83aab6 11:24:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:24:54 INFO - mozversion platform_version: 51.0a1 11:24:54 INFO - using testdate: 1471026294 11:24:54 INFO - actual date: 1471026294 11:24:54 INFO - starting webserver on 'localhost:49273' 11:24:54 INFO - SUITE-START | Running 2 tests 11:24:54 INFO - TEST-START | dromaeo_css 11:24:54 INFO - operating with platform_type : mac_ 11:24:54 INFO - Initialising browser for dromaeo_css test... 11:24:54 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpskWhtM/profile http://localhost:49273/getInfo.html) 11:24:57 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 11:24:57 INFO - PROCESS | 1679 | colorDepth:24 11:24:57 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 11:24:57 INFO - PROCESS | 1679 | __metrics 11:24:57 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:24:57 INFO - TEST-INFO | 1679: exit 0 11:24:57 INFO - Browser initialized. 11:24:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:57 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpskWhtM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:09 INFO - PROCESS | 1682 | RSS: Main: 254902272 11:25:09 INFO - PROCESS | 1682 | 11:25:59 INFO - PROCESS | 1682 | 1471026359524 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] 11:28:11 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 11:28:13 INFO - PROCESS | 1682 | RSS: Main: 268021760 11:28:13 INFO - PROCESS | 1682 | 11:31:15 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 11:31:16 INFO - PROCESS | 1682 | RSS: Main: 278515712 11:31:16 INFO - PROCESS | 1682 | 11:34:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 11:34:18 INFO - PROCESS | 1682 | RSS: Main: 282570752 11:34:18 INFO - PROCESS | 1682 | 11:37:20 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 11:37:21 INFO - PROCESS | 1682 | RSS: Main: 281837568 11:37:21 INFO - PROCESS | 1682 | 11:40:24 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 11:40:24 INFO - PROCESS | 1682 | RSS: Main: 286146560 11:40:24 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 11:43:27 INFO - PROCESS | 1682 | RSS: Main: 288059392 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | __start_tp_report 11:43:27 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 11:43:27 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 11:43:27 INFO - PROCESS | 1682 | |i|pagename|runs| 11:43:27 INFO - PROCESS | 1682 | |0;dojo.html;3222.5176418847327;3285.490748933915;3400.4559270516716;3442.9311413771734;3469.7397695172867;5016.4481906990295;5329.387120481146;5591.133374326976;5703.885922281557;5812.564057695674;5655.208270842075;5725.742341594628;5743.741531631076;5753.741081651326;5811.12833075039;5151.76817043232;5217.947820521803;5235.921461178085;5282.234076058989;5318.25544423781;5281.603879709037;5319.5478384337375;5358.410574836765;5376.489233522809;5390.5418039466695;5111.488851114896;5149.0216858797085;5209.453007434203;5218.895622087537;5254.737263136828;5189.636725429222;5202.531772140488;5215.921761173586;5239.056969745444;5261.789528418859;5176.327077479941;5178.508041736029;5184.507471790174;5201.479852014806;5209.869753256161;5525.696086715229;5577.69322687252;5587.944120558783;5600.131979543177;5622.240997465331;6131.662758548278;6142.2225331421305;6162.383761623847;6180.103884936659;6202.72087756052;6199.845003874939;6215.7513699451965;6227.688615569204;6236.87526249477;6280.15217945576;4785.569298763093;5719.685417302005;5805.274340707411;5872.706364681749;5879.323877754027;6265.028920517327;6268.028455589391;6269.8746025079245;6271.027990661455;6291.087792270096;6157.661328626879;6166.969165154145;6186.690665466709;6196.81409557714;6198.907016394758;6143.784967526115;6152.538559608047;6157.1072194532435;6172.8765424691255;6187.721552530147;6195.938040619626;6212.254529456494;6213.316535181127;6225.3774622538285;6260.655663938527;5049.293098966147;5062.240663900371;6175.888340098735;6232.283287422005;6239.438450539473;4907.214845624754;4941.431735350408;4977.1538838397555;4991.550760431506;5005.924911126336;3747.475353450519;3921.9607803922167;4351.086271882877;4503.909921801545;4509.706869053567;5043.915558154941;5855.38518455556;5861.238039054895;5869.090291004901;5884.7940322088525;6107.694615269219;6150.692465376714;6191.102290167901;6235.376462353728;6250.249970003629;5155.81416274259;5843.620164689281;5852.853678658068;5854.765809367577;5892.204552385373;5457;5485.780568777204;5489.533389661923;5517.36550296713;5528.087865502228;6192.225971753531;6216.937830621636;6249.750009999549;6254;6339.968300158562;6230.875382492415;6249.625022498482;6253.437190652863;6260;6289.213848268966;6341.841453963688;6343.61938283686;6366.6180029198395;6366.745330186741;6367.363263673781;6063.242094738158;6124.5039979263265;6142.04798256271;6161.075838624242;6266.561340706106;5475.959567682127;6211.006239001738;6255.78104766331;6268.6552239625435;6275.435210831047;5676.631018983753;5956.612820166675;6197.287311959002;6207.006878899354;6227.688615569113;6016.488598469179;6093.695315234309;6106.460667179974;6121.5139442231075;6146.125431743361;5892.145638882253;5961.403859614177;6036.3058248302;6039.275286965592;6058.182145410313;6108.419700128481;6110.7250173741395;6117.938820611915;6131.264248290234;6176.166217560572;5867.911981320198;5991.580589358878;5997.490213331916;6035.426634469718;6132.141360525156 11:43:27 INFO - PROCESS | 1682 | |1;ext.html;505.9721715305658;508.63632502760544;521.4967556308163;540.9242706021155;543.2855794630063;32263.67736322639;41738.747837564886;41846.16307673845;42027.78986105065;42138.157236855244;42242;42419.363709544385;42863.57136428635;42867.78566107173;42900.78549607247;9574.329796914219;9717.368371055858;9796.461194634328;9819.459929703864;9840.261980351466;9651.662191823287;9776.706698799011;9781.266405019616;9791;9807.803843923117;9752.951235243814;9779.511024448784;9781.559829807677;9794.608215671364;9799.118079372854;9668.951655241714;9702.175315098226;9763.951180244054;9780.853287200698;9793.90206097937;9642.71071867845;9703.563339649732;9729.902700973042;9732.659356922473;9749.122578967927;40041.59958400408;40432.98917527056;40473.59526404757;40588;40939.36242550294;2965.644122705268;3375.3418083473734;3437.157896315419;3442.7762195457217;3555.6977656899194;31275.37449251025;31866;31988.680113198803;32245;32732;2721.8502982335963;2753.559430491132;3214.7267482264037;3285.4086264472385;3371.258323168899;402794;477172.22827771626;499090;500553;506699;59910.70044649749;60236.397636023954;60364.396356036756;60398;61366;29166.562501562494;35451;35858.46212306817;36744.26511469809;60328.39671603228;16651.750223746654;16836.915815420845;16855.831441685426;16915.985040897587;16923.40768073136;12526.937365313115;12656.873431265754;12763.617091487271;12782.233066015882;12791.744165116832;19679.60640787176;19722.70415943762;19932.90033549823;19934.601307974048;20005.699914501292;8269.338452923752;8301.377396695152;8312.293455056268;8321.16788321163;8387.119352468026;873.8383399071192;938.8592859675528;972.873526441558;1059.8251288537458;1124.8200287954053;30939.381212376076;31184.376312473625;31531.684683153333;31639.20901977469;31713.24422843264;1005.6379703306803;1041.0994489766297;1095.4905968724581;1161.9825702614467;1236.4065248680683;15992.040477571383;16062.670912717824;16308.918455407647;16435.58911027234;16525;150406.49593504143;166733.16633416756;182599;190684;193460;58751.11873321904;58827.41172588219;59185;59338.81322373615;59438;1363.1480324797;1394.1774353131498;1411.1603595860242;1412.5903487988573;1417.808595839569;29537.556936646397;30490.627921743133;30513;30838.229044274074;31249.68750312468;52532.737336313076;52714.20928686149;52812.47187528075;52865.20702189547;52880.47119528755;611341;612989;613842;614477;615135;26678;27314;27459.725402745717;27623.86188069127;27700.722992769814;49007.26489102595;49086.01827963349;49558.504414956835;50286.74856625694;51072.744636276584;37347.439788402655;39559.60440395559;40245.59754402418;40515.1896962065;41604;31092.844535777178;40505.392419113145;40557.39163912485;40646.79676601598;42095;35946.8202658985;38992.80503597464;39767.602323977546;39933;41262;34727;35462.46806297959;36172.638273616925;36369.81815090908;36457.63542364542;25960.610590840774;25978;26219.475610488065;26376.4724705501;26522.734772652027 11:43:27 INFO - PROCESS | 1682 | |2;jquery.html;291.6514764855997;320.81553106963497;330.7734202071581;362.41391431782495;374.64783103882365;20227.292044778416;20405.693914591295;21492.785072149272;21534.94043335733;21791.346259612197;20535.794642053574;20609.27867524637;20834.166633334647;21042.579148417022;21619.216637088524;5866.413358664142;5909.970450147744;6164.10620460033;6164.938350616504;6167.383261673819;5988.880222395549;6057.606255593372;6159.7536098556;6164.96917515414;6174.012158054712;5827.970860145693;6118.082287656843;6133.11069894865;6148.477379422754;6153.815385538441;6200.844978875519;6225.19072520574;6228.906566401508;6260.186175797163;6267.62394256346;5141.203113517411;5959.851003724942;6026.367231440723;6057.3336932937345;6100.328963813977;13585.116967397087;13793.448262069505;14540;26660.46679066427;27005.86497067522;2117.1319758898776;2143.431990522513;2321.280403075052;2478.628205769131;2735.534959056965;12856.421461034275;13512.932435337858;14123.858761412357;15942.840571594252;16581.088040157785;1539.780980284261;1605.8233594304618;1939.9860432658786;1954.3550628292771;1976.2292705844732;112655;114791;126655.36672316672;130894.34552827175;133135;9365.672201472917;11707.473163707653;11813.763724725457;11891.643250702493;12053.0960177987;12397.442115104843;14899.255037248095;14927.850721492863;14933.328000240015;14940.626484337978;7186.964065179745;8450.788730281669;8730.650773969097;8829.381943264038;8839.718240855169;8551.914480855112;8552.401331906707;8608.827823443497;8761.167689069529;8781.20969112783;3614.6746792788776;3777.508923839883;4658.231391820379;4663.044075964419;4704.976475117603;1976.4762337980446;1996;2001.599680063993;2008.4777957730803;2046.5190680190144;897.3449381951082;959.5681943125621;998.2712619787595;1013.8681971343678;1060.5439660945867;21700.891495542422;22490.550188996127;22569.210077647203;22598.209062682727;22658.66012009821;862.7109918177356;914.4056363363867;928.758522784081;937.2174234514121;947.6493697332031;11621.53513859453;11799.056075513938;11887.762244755057;11934.283942963277;12032.338221397733;617428;622711;623231;631483;643318;139546.30226849005;150403;152271;152689;153885;827.4828232354778;881.2817553693719;1009.2430676992255;1011.6358111079858;1026.1841835740604;19722.90138549298;20376.0830762619;20558.794412056286;20575;20613.793862061186;57752.42247577639;59572;59676.80646387135;60366;61295.38704612897;85633;86500.13499864921;86631;86932.56533717291;87733.68399473885;7173.282671732785;8054.516728996279;8075.676972921017;8146.796330091795;8372.204640559137;11313.321200727984;11334.603288885179;13515.256660883746;13973.301334933416;14238.216898070705;10635.734106647396;11207.775844483227;11591;11597.18819682614;11775.116866234895;9273;11463.828042579202;11752.823707644564;11771.882281177079;11966.341851198267;11542.82685759731;11623.244489108181;11943.761124777282;12017.759644807229;12053.096017798876;7563.239417612642;7601.619919004138;7679.155292917663;7778.377729781717;7919.208079192034;9823.557939892578;10868.782624347627;11787.646370608896;11850;12138 11:43:27 INFO - PROCESS | 1682 | |3;mootools.html;1451.8983671143021;1522.9314680839361;1691.0868131209147;1873.297513432463;1892.4511891551451;7253.564786112837;7932.167122452146;8374.371922105844;8933.4193277437;8974.641014359426;8594.312455003601;8783.780405489866;8785.824283514326;8790.077041910587;8793.03276639569;2314.9421264468356;2348.8590684558894;2352.6706261123454;2355.7173139223232;2399.748026457223;2131.3925531223604;2306.423394151462;2364.6216605343147;2373.121944880388;2380.262118743195;1968.1536939116174;2352.6118190498546;2355.458244603742;2355.4817940053163;2358.740538540759;1895.5924476237606;2202.0421116814236;2205.2943058221376;2214.1918199856937;2221.3447033125185;2022.403390999644;2275.93031275302;2323.488832456857;2325.104834638659;2335.719713634358;7537.623118844036;7833.1775163608145;8602.709593560954;8846.5134417607;8848.115188481164;5173.3016042834115;5280.419153893069;5341.011912796145;5348.331458567679;5355.116405793039;3501.3172431375892;3564.1802385451233;3667.743257971943;3692.8153592320277;3713.1088538750773;933.7292185266265;1081.9891801081967;1099.6755956992627;1102.2614848051824;1113.604670342025;11405.942970285096;11426.771464570746;11590.884091159065;11591.884081159249;11623.244489108265;4566.383538222364;4705.200115980223;4789.066132104276;4811.975940120277;4813.4945830687975;9745.02549745034;9839.950800245953;9849.310548261554;9851.113399794052;9856.45789481571;5299.231611416323;5304.124819404755;5316.362036555561;5319.0957537218765;5328.4671532846405;4398.73607583546;4743.312219728189;4854.732989685531;4880.194767863263;4896.045271172158;3829.310724069694;3902.35611124167;3979;3987.003249187703;4012.257732319472;1087.9456027198607;1260.3698150924538;1272.1158794637822;1275.9681007974875;1279.7120647854158;908.7864351877304;919.8758167647416;922.4096578189964;940.3370623710268;950.0879156010169;5753.33836608787;5951.732172052268;6095.146679464879;6167.876642467126;6183.288921773964;415.20695471649003;426.9380939763717;440.5308346610849;448;449.2519954276159;3583.3191693578137;3634.1278093257956;3964.266610677034;4017.678585713136;4080.755154690669;9129.954350228207;10208.795824083625;10668.62659806903;10698.62554810578;10708.839367409495;10551.736206594896;10572.52423640938;10603.469826508797;10728.195385346131;10859.40273284961;6934.341237582422;6968.930310696828;8053.919460805317;8213.671453141927;8236.794080148044;5951.464368206882;5959.851003724768;5966.642001479925;5971.641701497924;5974.103884417372;8442.113578074459;9662.323637345318;9811.607535698493;9913.603455861685;10141.188704903738;9910.75223119399;10090.949545252226;10220.744481388025;10237.078662920372;10260.743481413025;6797.252302246848;7395.149557800922;7480.289372509603;7520.172780993977;7616.04799400075;8406.87389689143;8482.066972633129;8492.108328625405;8498.575071246536;8504.53225072627;7360.96319518399;7485.5508669480005;7500.1374841893885;7545.283198096172;7579.166291707797;7128.786136415916;7292.96353518229;7302.634868256672;7350.301721336465;7467.626618669154;6055.757769689163;6975.546589471668;7019.789406317818;7065.293470652894;7074.858502830018;4926.655134140576;4984.75076246179;5017.924731129109;5060.84817455477;5154.690718556899;5018.924716129188;5035.16919708244;5156.948430515797;5166.819161329336;5224.817131400383 11:43:27 INFO - PROCESS | 1682 | |4;prototype.html;285.4547813675879;298.18892612095095;300.43068385409634;310.95674013684095;314.3210664963679;4525.637948964083;4793.952060479394;5112.182050871861;5378.650387724795;5665.971670141648;4195.349720793282;5386.245925570413;5572.108462645978;5586.832395028156;5617.550595952324;3752.8311225994894;3922.27419935229;4223.028703398205;4269.551697071809;4309.956900430987;3425.075229687995;3910.7849068301234;4230.344296634026;4252.00155926714;4372.825086996516;3464.861405543775;4200.70595058346;4201.159768046387;4216.59942305482;4227.704060715751;3316.7014968652816;4222.2611043067645;4230;4242.469691288589;4256.489221293434;3019.8037127586636;3451.430513965193;3618.294432585647;3631.092226943264;3645.76302540334;4859.708417494961;5027.396712394536;5553.361363443215;5555.8888822223735;5581.274434323553;4851.902961940777;4870.878228044292;4878.560929516325;4900.142475066885;4906.969536397361;4939.259111133323;5880.882382352372;5931.703414829241;5943.108533719934;6037.184980027684;3318.4569175333586;3959.881203563869;3976.443297938291;4003.6396724294664;4120.835166593332;4992.700437973734;5159.406668233164;6214.409631085085;6272.247330320391;6352.428281454645;3787.6401741834484;4024.6981476389387;4035.7198183026494;4048.3117869962175;4082.3264161413626;4114.794260286973;4116.938245926313;4124;4139.958600414017;4140.855070072594;4874.8050077997195;4882.975585122052;4887.584555312838;4893.73084480357;4918.385201849769;4822.565969062731;5637.548996080303;5815.41845815415;6090.442014353982;6092.603980741238;1123.9943800280946;1247.5508816825936;1317.7298653775954;1372.3344178073626;1393.7839634856614;720.765751130874;780.9101953275332;819.496009953874;865.731623196811;869.7955980344741;4410.360497727876;4444.511103778582;4577.040859656439;4817.16947559925;4828.106800241966;4697.929531057037;4895.31465594817;5207.817726379559;5259.947400526023;5375.946240537544;4095.4675892133832;4703.623710103184;4709.576138147583;4743.881402964885;4816.8554943351755;3004.7896647234484;3018.758499320049;3163.9050828475183;3263.640999490054;3278.6229583597715;6137.723802428902;6369.585976911486;6389.520785941073;6398.2641996170105;6425.518086143558;4826.0830442215865;5367.490088441592;6093.573449858467;6176.8764624707255;6401.359864013654;6374.298827129012;6379.904301435482;6403.871922561522;6406.455451286693;6426.260979987362;5018.247262910447;5135.897282054413;5617.578681598815;6142.051815128674;6252.749890004349;5156.948430515647;5448.83653490396;5999.280086389661;6044.274687037584;6121.632702037892;5306.097963346163;5666.583354161459;6018;6216.968915155395;6492.610443373413;3472.600650925176;3559.110222444389;3941.482529226211;4004.619561141687;4005.1989602079116;5630.507915402503;5681.77272909079;5950.173667507899;6059.545534085049;6142.969285153546;4805.035845427607;5783.363829978614;5939.287285525765;6021.367756385692;6069.817905462844;5208.5312321891215;5956.851078723066;6000.459958603747;6043.2748070231855;6061.333253342217;4842;5227.843164705065;5625.324961004706;5803.854903627274;5896.054302080389;5308.442613525524;5671;6048.243969503812;6062.120492766077;6085.482733967662;5395.541378982831;5420.159875219348;5884.293884733859;5903.675297858659;5932.911006334822 11:43:27 INFO - PROCESS | 1682 | |5;yui.html;696.2376198063121;700.5096432497247;704.8097013806275;716.3910675925464;719.9496035277531;14318.856811431882;15762.133082680448;16018.439354622591;16136.838631613695;16158.596035099128;14608;14614.342354594042;14636.560903172895;14738.778918316233;14784.778228326557;695.2595485807624;863.0851297624538;865.0614083719172;873.10506730601;874.2088409988938;767.2404319723462;773.2306355176607;774.2760518914805;851.8849955256054;877.9078196789341;867.7353407210799;869.0310304011014;913.7624217703411;916.2669864108686;917.0096296000337;857.7726902370877;880.2913654508119;905.1943770044666;916.3722849847876;917.9219766319837;686.0258433025067;688.3460712323263;688.7830333444949;689.2590465249826;696.7039008421401;12706.491740330375;14657.193854338007;15123.621909452242;15138.167400792952;15145.621359465991;14637.268136593128;14730.337134828958;14935.775963360558;15077.849221507755;15694.68610627781;11884.702882427922;12137.817932731015;12319.384030798514;12347.320897350643;12399.380030998504;3843.385058390644;3859.3439115350457;4079.2249472600406;4097.180563887205;4099.0162361033135;107565;122476;122886.38556807248;123839.14241286388;124358;11302.434878256054;11448.54205831774;11471.311721296748;11472;11746.765064698659;23660.290191294287;23739.287821365386;23768.16811411627;23777.286681399586;24101;8104.918950810416;8209.630566624517;8252.21603947624;8288.046874609376;8315;3996.160806230724;4235.89866634671;4354.738715677069;4360.629346505519;4407.427034485497;3603.0992251937014;3713.5543734751463;3745.4943582616543;3746.400575907842;3756.1924186300075;659.6839305585388;662.0532638327143;662.6918482905376;668.4518694670323;668.6890595872942;601.9668918209541;660.2539130782282;665.2416245480157;689.0525527399825;696.2445746365149;8780.648774048967;9183.311251656152;9429.905700942903;9638.566264518113;9688.783915209602;636.7166610858123;642.5566359212129;671.7548094945407;674.4199988010307;676.5839009009424;4502.729836209773;4664.463586687507;4672;4677.906441871143;4705.294205869079;161102.1944890268;163954;165811;166555;171384;136336;137720.31139844438;138229;140048;147489;105413.9458605404;106663.93336066695;108802.91197087927;110886;123343;9381.390209636353;9504.192143667866;9812.116909478182;9951.303408761607;10159.187265018632;59059.40940590539;61034.38965610465;61816;62283.37716622776;63664.68167659132;83194.58402707947;88175;90052.64921026058;91153;91703.08296916945;11206.159538034517;11290.830637540608;11514.36670983104;11701.88298117042;13118.475260989835;14420.927895360455;15091.698166036398;15571.532854014398;15791.526254212393;15876.126813024932;13670.163193273647;13750.587482375544;14035.00059592393;14167.079139856289;14371.92814035923;13768.586942391745;13826.723465530835;14082.859171408154;14159;14255.075564799034;13769.380377883219;13804.792928105886;13887.722245555235;14103.506377276746;14162;9749.610015599297;10086.596536138471;11222.719432013939;11499.425028748696;11769.17615766888;8671.956640216758;10096.990300969845;11423.687130731994;11562.248453850472;11823.23148995347 11:43:27 INFO - PROCESS | 1682 | __end_tp_report 11:43:27 INFO - PROCESS | 1682 | __start_cc_report 11:43:27 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,417 11:43:27 INFO - PROCESS | 1682 | __end_cc_report 11:43:27 INFO - PROCESS | 1682 | __startTimestamp1471027407622__endTimestamp 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | ------- Summary: start ------- 11:43:27 INFO - PROCESS | 1682 | Number of tests: 6 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | [#0] dojo.html Cycles:165 Average:5716.15 Median:5961.40 stddev:660.50 (11.1%) stddev-sans-first:632.90 11:43:27 INFO - PROCESS | 1682 | Values: 3222.5 3285.5 3400.5 3442.9 3469.7 5016.4 5329.4 5591.1 5703.9 5812.6 5655.2 5725.7 5743.7 5753.7 5811.1 5151.8 5217.9 5235.9 5282.2 5318.3 5281.6 5319.5 5358.4 5376.5 5390.5 5111.5 5149.0 5209.5 5218.9 5254.7 5189.6 5202.5 5215.9 5239.1 5261.8 5176.3 5178.5 5184.5 5201.5 5209.9 5525.7 5577.7 5587.9 5600.1 5622.2 6131.7 6142.2 6162.4 6180.1 6202.7 6199.8 6215.8 6227.7 6236.9 6280.2 4785.6 5719.7 5805.3 5872.7 5879.3 6265.0 6268.0 6269.9 6271.0 6291.1 6157.7 6167.0 6186.7 6196.8 6198.9 6143.8 6152.5 6157.1 6172.9 6187.7 6195.9 6212.3 6213.3 6225.4 6260.7 5049.3 5062.2 6175.9 6232.3 6239.4 4907.2 4941.4 4977.2 4991.6 5005.9 3747.5 3922.0 4351.1 4503.9 4509.7 5043.9 5855.4 5861.2 5869.1 5884.8 6107.7 6150.7 6191.1 6235.4 6250.2 5155.8 5843.6 5852.9 5854.8 5892.2 5457.0 5485.8 5489.5 5517.4 5528.1 6192.2 6216.9 6249.8 6254.0 6340.0 6230.9 6249.6 6253.4 6260.0 6289.2 6341.8 6343.6 6366.6 6366.7 6367.4 6063.2 6124.5 6142.0 6161.1 6266.6 5476.0 6211.0 6255.8 6268.7 6275.4 5676.6 5956.6 6197.3 6207.0 6227.7 6016.5 6093.7 6106.5 6121.5 6146.1 5892.1 5961.4 6036.3 6039.3 6058.2 6108.4 6110.7 6117.9 6131.3 6176.2 5867.9 5991.6 5997.5 6035.4 6132.1 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | [#1] ext.html Cycles:180 Average:57970.33 Median:221519.80 stddev:123656.51 (55.8%) stddev-sans-first:123928.13 11:43:27 INFO - PROCESS | 1682 | Values: 506.0 508.6 521.5 540.9 543.3 32263.7 41738.7 41846.2 42027.8 42138.2 42242.0 42419.4 42863.6 42867.8 42900.8 9574.3 9717.4 9796.5 9819.5 9840.3 9651.7 9776.7 9781.3 9791.0 9807.8 9753.0 9779.5 9781.6 9794.6 9799.1 9669.0 9702.2 9764.0 9780.9 9793.9 9642.7 9703.6 9729.9 9732.7 9749.1 40041.6 40433.0 40473.6 40588.0 40939.4 2965.6 3375.3 3437.2 3442.8 3555.7 31275.4 31866.0 31988.7 32245.0 32732.0 2721.9 2753.6 3214.7 3285.4 3371.3 402794.0 477172.2 499090.0 500553.0 506699.0 59910.7 60236.4 60364.4 60398.0 61366.0 29166.6 35451.0 35858.5 36744.3 60328.4 16651.8 16836.9 16855.8 16916.0 16923.4 12526.9 12656.9 12763.6 12782.2 12791.7 19679.6 19722.7 19932.9 19934.6 20005.7 8269.3 8301.4 8312.3 8321.2 8387.1 873.8 938.9 972.9 1059.8 1124.8 30939.4 31184.4 31531.7 31639.2 31713.2 1005.6 1041.1 1095.5 1162.0 1236.4 15992.0 16062.7 16308.9 16435.6 16525.0 150406.5 166733.2 182599.0 190684.0 193460.0 58751.1 58827.4 59185.0 59338.8 59438.0 1363.1 1394.2 1411.2 1412.6 1417.8 29537.6 30490.6 30513.0 30838.2 31249.7 52532.7 52714.2 52812.5 52865.2 52880.5 611341.0 612989.0 613842.0 614477.0 615135.0 26678.0 27314.0 27459.7 27623.9 27700.7 49007.3 49086.0 49558.5 50286.7 51072.7 37347.4 39559.6 40245.6 40515.2 41604.0 31092.8 40505.4 40557.4 40646.8 42095.0 35946.8 38992.8 39767.6 39933.0 41262.0 34727.0 35462.5 36172.6 36369.8 36457.6 25960.6 25978.0 26219.5 26376.5 26522.7 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | [#2] jquery.html Cycles:180 Average:37191.96 Median:22628.43 stddev:105330.48 (465.5%) stddev-sans-first:105589.52 11:43:27 INFO - PROCESS | 1682 | Values: 291.7 320.8 330.8 362.4 374.6 20227.3 20405.7 21492.8 21534.9 21791.3 20535.8 20609.3 20834.2 21042.6 21619.2 5866.4 5910.0 6164.1 6164.9 6167.4 5988.9 6057.6 6159.8 6165.0 6174.0 5828.0 6118.1 6133.1 6148.5 6153.8 6200.8 6225.2 6228.9 6260.2 6267.6 5141.2 5959.9 6026.4 6057.3 6100.3 13585.1 13793.4 14540.0 26660.5 27005.9 2117.1 2143.4 2321.3 2478.6 2735.5 12856.4 13512.9 14123.9 15942.8 16581.1 1539.8 1605.8 1940.0 1954.4 1976.2 112655.0 114791.0 126655.4 130894.3 133135.0 9365.7 11707.5 11813.8 11891.6 12053.1 12397.4 14899.3 14927.9 14933.3 14940.6 7187.0 8450.8 8730.7 8829.4 8839.7 8551.9 8552.4 8608.8 8761.2 8781.2 3614.7 3777.5 4658.2 4663.0 4705.0 1976.5 1996.0 2001.6 2008.5 2046.5 897.3 959.6 998.3 1013.9 1060.5 21700.9 22490.6 22569.2 22598.2 22658.7 862.7 914.4 928.8 937.2 947.6 11621.5 11799.1 11887.8 11934.3 12032.3 617428.0 622711.0 623231.0 631483.0 643318.0 139546.3 150403.0 152271.0 152689.0 153885.0 827.5 881.3 1009.2 1011.6 1026.2 19722.9 20376.1 20558.8 20575.0 20613.8 57752.4 59572.0 59676.8 60366.0 61295.4 85633.0 86500.1 86631.0 86932.6 87733.7 7173.3 8054.5 8075.7 8146.8 8372.2 11313.3 11334.6 13515.3 13973.3 14238.2 10635.7 11207.8 11591.0 11597.2 11775.1 9273.0 11463.8 11752.8 11771.9 11966.3 11542.8 11623.2 11943.8 12017.8 12053.1 7563.2 7601.6 7679.2 7778.4 7919.2 9823.6 10868.8 11787.6 11850.0 12138.0 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | [#3] mootools.html Cycles:180 Average:5637.59 Median:5018.42 stddev:3166.53 (63.1%) stddev-sans-first:3159.79 11:43:27 INFO - PROCESS | 1682 | Values: 1451.9 1522.9 1691.1 1873.3 1892.5 7253.6 7932.2 8374.4 8933.4 8974.6 8594.3 8783.8 8785.8 8790.1 8793.0 2314.9 2348.9 2352.7 2355.7 2399.7 2131.4 2306.4 2364.6 2373.1 2380.3 1968.2 2352.6 2355.5 2355.5 2358.7 1895.6 2202.0 2205.3 2214.2 2221.3 2022.4 2275.9 2323.5 2325.1 2335.7 7537.6 7833.2 8602.7 8846.5 8848.1 5173.3 5280.4 5341.0 5348.3 5355.1 3501.3 3564.2 3667.7 3692.8 3713.1 933.7 1082.0 1099.7 1102.3 1113.6 11405.9 11426.8 11590.9 11591.9 11623.2 4566.4 4705.2 4789.1 4812.0 4813.5 9745.0 9840.0 9849.3 9851.1 9856.5 5299.2 5304.1 5316.4 5319.1 5328.5 4398.7 4743.3 4854.7 4880.2 4896.0 3829.3 3902.4 3979.0 3987.0 4012.3 1087.9 1260.4 1272.1 1276.0 1279.7 908.8 919.9 922.4 940.3 950.1 5753.3 5951.7 6095.1 6167.9 6183.3 415.2 426.9 440.5 448.0 449.3 3583.3 3634.1 3964.3 4017.7 4080.8 9130.0 10208.8 10668.6 10698.6 10708.8 10551.7 10572.5 10603.5 10728.2 10859.4 6934.3 6968.9 8053.9 8213.7 8236.8 5951.5 5959.9 5966.6 5971.6 5974.1 8442.1 9662.3 9811.6 9913.6 10141.2 9910.8 10090.9 10220.7 10237.1 10260.7 6797.3 7395.1 7480.3 7520.2 7616.0 8406.9 8482.1 8492.1 8498.6 8504.5 7361.0 7485.6 7500.1 7545.3 7579.2 7128.8 7293.0 7302.6 7350.3 7467.6 6055.8 6975.5 7019.8 7065.3 7074.9 4926.7 4984.8 5017.9 5060.8 5154.7 5018.9 5035.2 5156.9 5166.8 5224.8 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | [#4] prototype.html Cycles:180 Average:4678.12 Median:4965.98 stddev:1485.18 (29.9%) stddev-sans-first:1452.29 11:43:27 INFO - PROCESS | 1682 | Values: 285.5 298.2 300.4 311.0 314.3 4525.6 4794.0 5112.2 5378.7 5666.0 4195.3 5386.2 5572.1 5586.8 5617.6 3752.8 3922.3 4223.0 4269.6 4310.0 3425.1 3910.8 4230.3 4252.0 4372.8 3464.9 4200.7 4201.2 4216.6 4227.7 3316.7 4222.3 4230.0 4242.5 4256.5 3019.8 3451.4 3618.3 3631.1 3645.8 4859.7 5027.4 5553.4 5555.9 5581.3 4851.9 4870.9 4878.6 4900.1 4907.0 4939.3 5880.9 5931.7 5943.1 6037.2 3318.5 3959.9 3976.4 4003.6 4120.8 4992.7 5159.4 6214.4 6272.2 6352.4 3787.6 4024.7 4035.7 4048.3 4082.3 4114.8 4116.9 4124.0 4140.0 4140.9 4874.8 4883.0 4887.6 4893.7 4918.4 4822.6 5637.5 5815.4 6090.4 6092.6 1124.0 1247.6 1317.7 1372.3 1393.8 720.8 780.9 819.5 865.7 869.8 4410.4 4444.5 4577.0 4817.2 4828.1 4697.9 4895.3 5207.8 5259.9 5375.9 4095.5 4703.6 4709.6 4743.9 4816.9 3004.8 3018.8 3163.9 3263.6 3278.6 6137.7 6369.6 6389.5 6398.3 6425.5 4826.1 5367.5 6093.6 6176.9 6401.4 6374.3 6379.9 6403.9 6406.5 6426.3 5018.2 5135.9 5617.6 6142.1 6252.7 5156.9 5448.8 5999.3 6044.3 6121.6 5306.1 5666.6 6018.0 6217.0 6492.6 3472.6 3559.1 3941.5 4004.6 4005.2 5630.5 5681.8 5950.2 6059.5 6143.0 4805.0 5783.4 5939.3 6021.4 6069.8 5208.5 5956.9 6000.5 6043.3 6061.3 4842.0 5227.8 5625.3 5803.9 5896.1 5308.4 5671.0 6048.2 6062.1 6085.5 5395.5 5420.2 5884.3 5903.7 5932.9 11:43:27 INFO - PROCESS | 1682 | 11:43:27 INFO - PROCESS | 1682 | [#5] yui.html Cycles:180 Average:26007.90 Median:3729.52 stddev:42470.38 (1138.8%) stddev-sans-first:42547.00 11:43:27 INFO - PROCESS | 1682 | Values: 696.2 700.5 704.8 716.4 719.9 14318.9 15762.1 16018.4 16136.8 16158.6 14608.0 14614.3 14636.6 14738.8 14784.8 695.3 863.1 865.1 873.1 874.2 767.2 773.2 774.3 851.9 877.9 867.7 869.0 913.8 916.3 917.0 857.8 880.3 905.2 916.4 917.9 686.0 688.3 688.8 689.3 696.7 12706.5 14657.2 15123.6 15138.2 15145.6 14637.3 14730.3 14935.8 15077.8 15694.7 11884.7 12137.8 12319.4 12347.3 12399.4 3843.4 3859.3 4079.2 4097.2 4099.0 107565.0 122476.0 122886.4 123839.1 124358.0 11302.4 11448.5 11471.3 11472.0 11746.8 23660.3 23739.3 23768.2 23777.3 24101.0 8104.9 8209.6 8252.2 8288.0 8315.0 3996.2 4235.9 4354.7 4360.6 4407.4 3603.1 3713.6 3745.5 3746.4 3756.2 659.7 662.1 662.7 668.5 668.7 602.0 660.3 665.2 689.1 696.2 8780.6 9183.3 9429.9 9638.6 9688.8 636.7 642.6 671.8 674.4 676.6 4502.7 4664.5 4672.0 4677.9 4705.3 161102.2 163954.0 165811.0 166555.0 171384.0 136336.0 137720.3 138229.0 140048.0 147489.0 105413.9 106663.9 108802.9 110886.0 123343.0 9381.4 9504.2 9812.1 9951.3 10159.2 59059.4 61034.4 61816.0 62283.4 63664.7 83194.6 88175.0 90052.6 91153.0 91703.1 11206.2 11290.8 11514.4 11701.9 13118.5 14420.9 15091.7 15571.5 15791.5 15876.1 13670.2 13750.6 14035.0 14167.1 14371.9 13768.6 13826.7 14082.9 14159.0 14255.1 13769.4 13804.8 13887.7 14103.5 14162.0 9749.6 10086.6 11222.7 11499.4 11769.2 8672.0 10097.0 11423.7 11562.2 11823.2 11:43:27 INFO - PROCESS | 1682 | -------- Summary: end -------- 11:43:27 INFO - PROCESS | 1682 | 11:43:28 INFO - TEST-INFO | 1682: exit 0 11:43:28 INFO - TEST-OK | dromaeo_css | took 1114204ms 11:43:28 INFO - TEST-START | kraken 11:43:28 INFO - operating with platform_type : mac_ 11:43:28 INFO - Initialising browser for kraken test... 11:43:28 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmp77AsgW/profile http://localhost:49273/getInfo.html) 11:43:31 INFO - PROCESS | 1695 | __metrics Screen width/height:1600/1200 11:43:31 INFO - PROCESS | 1695 | colorDepth:24 11:43:31 INFO - PROCESS | 1695 | Browser inner width/height: 1024/689 11:43:31 INFO - PROCESS | 1695 | __metrics 11:43:31 ERROR - PROCESS | 1695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:43:32 INFO - TEST-INFO | 1695: exit 0 11:43:32 INFO - Browser initialized. 11:43:32 INFO - Running cycle 1/1 for kraken test... 11:43:32 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmp77AsgW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:43 INFO - PROCESS | 1697 | RSS: Main: 254840832 11:43:43 INFO - PROCESS | 1697 | 11:43:46 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:47 INFO - PROCESS | 1697 | RSS: Main: 267640832 11:43:47 INFO - PROCESS | 1697 | 11:43:50 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 11:43:51 INFO - PROCESS | 1697 | RSS: Main: 276283392 11:43:51 INFO - PROCESS | 1697 | 11:43:54 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 11:43:55 INFO - PROCESS | 1697 | RSS: Main: 278994944 11:43:55 INFO - PROCESS | 1697 | 11:43:57 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 11:43:57 INFO - PROCESS | 1697 | RSS: Main: 281427968 11:43:57 INFO - PROCESS | 1697 | 11:43:59 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:00 INFO - PROCESS | 1697 | RSS: Main: 282136576 11:44:00 INFO - PROCESS | 1697 | 11:44:03 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:03 INFO - PROCESS | 1697 | RSS: Main: 282157056 11:44:03 INFO - PROCESS | 1697 | 11:44:06 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:07 INFO - PROCESS | 1697 | RSS: Main: 281915392 11:44:07 INFO - PROCESS | 1697 | 11:44:10 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 11:44:11 INFO - PROCESS | 1697 | RSS: Main: 282669056 11:44:11 INFO - PROCESS | 1697 | 11:44:12 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:13 INFO - PROCESS | 1697 | RSS: Main: 282296320 11:44:13 INFO - PROCESS | 1697 | 11:44:15 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:16 INFO - PROCESS | 1697 | RSS: Main: 282341376 11:44:16 INFO - PROCESS | 1697 | 11:44:18 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:19 INFO - PROCESS | 1697 | RSS: Main: 282685440 11:44:19 INFO - PROCESS | 1697 | 11:44:22 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:22 INFO - PROCESS | 1697 | RSS: Main: 282918912 11:44:22 INFO - PROCESS | 1697 | 11:44:25 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:26 INFO - PROCESS | 1697 | RSS: Main: 282796032 11:44:26 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 11:44:28 INFO - PROCESS | 1697 | RSS: Main: 283541504 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | __start_tp_report 11:44:28 INFO - PROCESS | 1697 | _x_x_mozilla_page_load 11:44:28 INFO - PROCESS | 1697 | _x_x_mozilla_page_load_details 11:44:28 INFO - PROCESS | 1697 | |i|pagename|runs| 11:44:28 INFO - PROCESS | 1697 | |0;ai-astar;108;118;108;120;117;117;115;118;118;119 11:44:28 INFO - PROCESS | 1697 | |1;audio-beat-detection;139;113;136;180;141;166;148;109;155;111 11:44:28 INFO - PROCESS | 1697 | |2;audio-dft;200;208;206;234;195;195;196;197;196;272 11:44:28 INFO - PROCESS | 1697 | |3;audio-fft;67;83;75;142;59;59;59;64;136;60 11:44:28 INFO - PROCESS | 1697 | |4;audio-oscillator;70;73;119;71;72;76;98;95;61;119 11:44:28 INFO - PROCESS | 1697 | |5;imaging-gaussian-blur;89;86;88;90;88;86;136;132;89;85 11:44:28 INFO - PROCESS | 1697 | |6;imaging-darkroom;94;96;95;106;152;95;96;131;134;131 11:44:28 INFO - PROCESS | 1697 | |7;imaging-desaturate;109;102;90;91;127;145;147;92;91;92 11:44:28 INFO - PROCESS | 1697 | |8;json-parse-financial;56;56;57;77;83;84;66;56;57;55 11:44:28 INFO - PROCESS | 1697 | |9;json-stringify-tinderbox;83;106;102;101;85;75;96;88;66;95 11:44:28 INFO - PROCESS | 1697 | |10;stanford-crypto-aes;94;103;112;85;85;83;85;90;110;87 11:44:28 INFO - PROCESS | 1697 | |11;stanford-crypto-ccm;141;137;134;160;180;148;155;137;151;135 11:44:28 INFO - PROCESS | 1697 | |12;stanford-crypto-pbkdf2;169;170;166;168;168;168;168;168;231;166 11:44:28 INFO - PROCESS | 1697 | |13;stanford-crypto-sha256-iterative;68;71;68;70;68;67;69;65;67;70 11:44:28 INFO - PROCESS | 1697 | __end_tp_report 11:44:28 INFO - PROCESS | 1697 | __start_cc_report 11:44:28 INFO - PROCESS | 1697 | _x_x_mozilla_cycle_collect,1055 11:44:28 INFO - PROCESS | 1697 | __end_cc_report 11:44:28 INFO - PROCESS | 1697 | __startTimestamp1471027468284__endTimestamp 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | ------- Summary: start ------- 11:44:28 INFO - PROCESS | 1697 | Number of tests: 14 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#0] ai-astar Cycles:10 Average:115.80 Median:118.00 stddev:4.32 (3.7%) stddev-sans-first:3.54 11:44:28 INFO - PROCESS | 1697 | Values: 108.0 118.0 108.0 120.0 117.0 117.0 115.0 118.0 118.0 119.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:144.50 stddev:23.84 (16.5%) stddev-sans-first:25.28 11:44:28 INFO - PROCESS | 1697 | Values: 139.0 113.0 136.0 180.0 141.0 166.0 148.0 109.0 155.0 111.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#2] audio-dft Cycles:10 Average:209.90 Median:203.00 stddev:24.83 (12.2%) stddev-sans-first:26.08 11:44:28 INFO - PROCESS | 1697 | Values: 200.0 208.0 206.0 234.0 195.0 195.0 196.0 197.0 196.0 272.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#3] audio-fft Cycles:10 Average:80.40 Median:62.00 stddev:31.90 (51.5%) stddev-sans-first:33.47 11:44:28 INFO - PROCESS | 1697 | Values: 67.0 83.0 75.0 142.0 59.0 59.0 59.0 64.0 136.0 60.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:72.50 stddev:21.00 (29.0%) stddev-sans-first:21.53 11:44:28 INFO - PROCESS | 1697 | Values: 70.0 73.0 119.0 71.0 72.0 76.0 98.0 95.0 61.0 119.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:88.00 stddev:19.64 (22.3%) stddev-sans-first:20.62 11:44:28 INFO - PROCESS | 1697 | Values: 89.0 86.0 88.0 90.0 88.0 86.0 136.0 132.0 89.0 85.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#6] imaging-darkroom Cycles:10 Average:113.00 Median:94.50 stddev:21.72 (23.0%) stddev-sans-first:21.92 11:44:28 INFO - PROCESS | 1697 | Values: 94.0 96.0 95.0 106.0 152.0 95.0 96.0 131.0 134.0 131.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#7] imaging-desaturate Cycles:10 Average:108.60 Median:90.50 stddev:22.85 (25.2%) stddev-sans-first:24.23 11:44:28 INFO - PROCESS | 1697 | Values: 109.0 102.0 90.0 91.0 127.0 145.0 147.0 92.0 91.0 92.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:61.50 stddev:12.02 (19.5%) stddev-sans-first:12.33 11:44:28 INFO - PROCESS | 1697 | Values: 56.0 56.0 57.0 77.0 83.0 84.0 66.0 56.0 57.0 55.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#9] json-stringify-tinderbox Cycles:10 Average:89.70 Median:84.00 stddev:12.74 (15.2%) stddev-sans-first:13.28 11:44:28 INFO - PROCESS | 1697 | Values: 83.0 106.0 102.0 101.0 85.0 75.0 96.0 88.0 66.0 95.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:85.00 stddev:10.99 (12.9%) stddev-sans-first:11.65 11:44:28 INFO - PROCESS | 1697 | Values: 94.0 103.0 112.0 85.0 85.0 83.0 85.0 90.0 110.0 87.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:149.50 stddev:14.46 (9.7%) stddev-sans-first:15.13 11:44:28 INFO - PROCESS | 1697 | Values: 141.0 137.0 134.0 160.0 180.0 148.0 155.0 137.0 151.0 135.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:168.00 stddev:19.99 (11.9%) stddev-sans-first:21.12 11:44:28 INFO - PROCESS | 1697 | Values: 169.0 170.0 166.0 168.0 168.0 168.0 168.0 168.0 231.0 166.0 11:44:28 INFO - PROCESS | 1697 | 11:44:28 INFO - PROCESS | 1697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.77 (2.6%) stddev-sans-first:1.87 11:44:28 INFO - PROCESS | 1697 | Values: 68.0 71.0 68.0 70.0 68.0 67.0 69.0 65.0 67.0 70.0 11:44:28 INFO - PROCESS | 1697 | -------- Summary: end -------- 11:44:28 INFO - PROCESS | 1697 | 11:44:29 INFO - TEST-INFO | 1697: exit 0 11:44:29 INFO - TEST-OK | kraken | took 60874ms 11:44:29 INFO - SUITE-END | took 1175s 11:44:29 INFO - Completed test suite (00:19:35) 11:44:29 INFO - javascript benchmark 11:44:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7384.107331134012, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.5176418847327, 3285.490748933915, 3400.4559270516716, 3442.9311413771734, 3469.7397695172867, 5016.4481906990295, 5329.387120481146, 5591.133374326976, 5703.885922281557, 5812.564057695674, 5655.208270842075, 5725.742341594628, 5743.741531631076, 5753.741081651326, 5811.12833075039, 5151.76817043232, 5217.947820521803, 5235.921461178085, 5282.234076058989, 5318.25544423781, 5281.603879709037, 5319.5478384337375, 5358.410574836765, 5376.489233522809, 5390.5418039466695, 5111.488851114896, 5149.0216858797085, 5209.453007434203, 5218.895622087537, 5254.737263136828, 5189.636725429222, 5202.531772140488, 5215.921761173586, 5239.056969745444, 5261.789528418859, 5176.327077479941, 5178.508041736029, 5184.507471790174, 5201.479852014806, 5209.869753256161, 5525.696086715229, 5577.69322687252, 5587.944120558783, 5600.131979543177, 5622.240997465331, 6131.662758548278, 6142.2225331421305, 6162.383761623847, 6180.103884936659, 6202.72087756052, 6199.845003874939, 6215.7513699451965, 6227.688615569204, 6236.87526249477, 6280.15217945576, 4785.569298763093, 5719.685417302005, 5805.274340707411, 5872.706364681749, 5879.323877754027, 6265.028920517327, 6268.028455589391, 6269.8746025079245, 6271.027990661455, 6291.087792270096, 6157.661328626879, 6166.969165154145, 6186.690665466709, 6196.81409557714, 6198.907016394758, 6143.784967526115, 6152.538559608047, 6157.1072194532435, 6172.8765424691255, 6187.721552530147, 6195.938040619626, 6212.254529456494, 6213.316535181127, 6225.3774622538285, 6260.655663938527, 5049.293098966147, 5062.240663900371, 6175.888340098735, 6232.283287422005, 6239.438450539473, 4907.214845624754, 4941.431735350408, 4977.1538838397555, 4991.550760431506, 5005.924911126336, 3747.475353450519, 3921.9607803922167, 4351.086271882877, 4503.909921801545, 4509.706869053567, 5043.915558154941, 5855.38518455556, 5861.238039054895, 5869.090291004901, 5884.7940322088525, 6107.694615269219, 6150.692465376714, 6191.102290167901, 6235.376462353728, 6250.249970003629, 5155.81416274259, 5843.620164689281, 5852.853678658068, 5854.765809367577, 5892.204552385373, 5457.0, 5485.780568777204, 5489.533389661923, 5517.36550296713, 5528.087865502228, 6192.225971753531, 6216.937830621636, 6249.750009999549, 6254.0, 6339.968300158562, 6230.875382492415, 6249.625022498482, 6253.437190652863, 6260.0, 6289.213848268966, 6341.841453963688, 6343.61938283686, 6366.6180029198395, 6366.745330186741, 6367.363263673781, 6063.242094738158, 6124.5039979263265, 6142.04798256271, 6161.075838624242, 6266.561340706106, 5475.959567682127, 6211.006239001738, 6255.78104766331, 6268.6552239625435, 6275.435210831047, 5676.631018983753, 5956.612820166675, 6197.287311959002, 6207.006878899354, 6227.688615569113, 6016.488598469179, 6093.695315234309, 6106.460667179974, 6121.5139442231075, 6146.125431743361, 5892.145638882253, 5961.403859614177, 6036.3058248302, 6039.275286965592, 6058.182145410313, 6108.419700128481, 6110.7250173741395, 6117.938820611915, 6131.264248290234, 6176.166217560572, 5867.911981320198, 5991.580589358878, 5997.490213331916, 6035.426634469718, 6132.141360525156], "value": 5674.134539856395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.9721715305658, 508.63632502760544, 521.4967556308163, 540.9242706021155, 543.2855794630063, 32263.67736322639, 41738.747837564886, 41846.16307673845, 42027.78986105065, 42138.157236855244, 42242.0, 42419.363709544385, 42863.57136428635, 42867.78566107173, 42900.78549607247, 9574.329796914219, 9717.368371055858, 9796.461194634328, 9819.459929703864, 9840.261980351466, 9651.662191823287, 9776.706698799011, 9781.266405019616, 9791.0, 9807.803843923117, 9752.951235243814, 9779.511024448784, 9781.559829807677, 9794.608215671364, 9799.118079372854, 9668.951655241714, 9702.175315098226, 9763.951180244054, 9780.853287200698, 9793.90206097937, 9642.71071867845, 9703.563339649732, 9729.902700973042, 9732.659356922473, 9749.122578967927, 40041.59958400408, 40432.98917527056, 40473.59526404757, 40588.0, 40939.36242550294, 2965.644122705268, 3375.3418083473734, 3437.157896315419, 3442.7762195457217, 3555.6977656899194, 31275.37449251025, 31866.0, 31988.680113198803, 32245.0, 32732.0, 2721.8502982335963, 2753.559430491132, 3214.7267482264037, 3285.4086264472385, 3371.258323168899, 402794.0, 477172.22827771626, 499090.0, 500553.0, 506699.0, 59910.70044649749, 60236.397636023954, 60364.396356036756, 60398.0, 61366.0, 29166.562501562494, 35451.0, 35858.46212306817, 36744.26511469809, 60328.39671603228, 16651.750223746654, 16836.915815420845, 16855.831441685426, 16915.985040897587, 16923.40768073136, 12526.937365313115, 12656.873431265754, 12763.617091487271, 12782.233066015882, 12791.744165116832, 19679.60640787176, 19722.70415943762, 19932.90033549823, 19934.601307974048, 20005.699914501292, 8269.338452923752, 8301.377396695152, 8312.293455056268, 8321.16788321163, 8387.119352468026, 873.8383399071192, 938.8592859675528, 972.873526441558, 1059.8251288537458, 1124.8200287954053, 30939.381212376076, 31184.376312473625, 31531.684683153333, 31639.20901977469, 31713.24422843264, 1005.6379703306803, 1041.0994489766297, 1095.4905968724581, 1161.9825702614467, 1236.4065248680683, 15992.040477571383, 16062.670912717824, 16308.918455407647, 16435.58911027234, 16525.0, 150406.49593504143, 166733.16633416756, 182599.0, 190684.0, 193460.0, 58751.11873321904, 58827.41172588219, 59185.0, 59338.81322373615, 59438.0, 1363.1480324797, 1394.1774353131498, 1411.1603595860242, 1412.5903487988573, 1417.808595839569, 29537.556936646397, 30490.627921743133, 30513.0, 30838.229044274074, 31249.68750312468, 52532.737336313076, 52714.20928686149, 52812.47187528075, 52865.20702189547, 52880.47119528755, 611341.0, 612989.0, 613842.0, 614477.0, 615135.0, 26678.0, 27314.0, 27459.725402745717, 27623.86188069127, 27700.722992769814, 49007.26489102595, 49086.01827963349, 49558.504414956835, 50286.74856625694, 51072.744636276584, 37347.439788402655, 39559.60440395559, 40245.59754402418, 40515.1896962065, 41604.0, 31092.844535777178, 40505.392419113145, 40557.39163912485, 40646.79676601598, 42095.0, 35946.8202658985, 38992.80503597464, 39767.602323977546, 39933.0, 41262.0, 34727.0, 35462.46806297959, 36172.638273616925, 36369.81815090908, 36457.63542364542, 25960.610590840774, 25978.0, 26219.475610488065, 26376.4724705501, 26522.734772652027], "value": 19486.791737564465, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.6514764855997, 320.81553106963497, 330.7734202071581, 362.41391431782495, 374.64783103882365, 20227.292044778416, 20405.693914591295, 21492.785072149272, 21534.94043335733, 21791.346259612197, 20535.794642053574, 20609.27867524637, 20834.166633334647, 21042.579148417022, 21619.216637088524, 5866.413358664142, 5909.970450147744, 6164.10620460033, 6164.938350616504, 6167.383261673819, 5988.880222395549, 6057.606255593372, 6159.7536098556, 6164.96917515414, 6174.012158054712, 5827.970860145693, 6118.082287656843, 6133.11069894865, 6148.477379422754, 6153.815385538441, 6200.844978875519, 6225.19072520574, 6228.906566401508, 6260.186175797163, 6267.62394256346, 5141.203113517411, 5959.851003724942, 6026.367231440723, 6057.3336932937345, 6100.328963813977, 13585.116967397087, 13793.448262069505, 14540.0, 26660.46679066427, 27005.86497067522, 2117.1319758898776, 2143.431990522513, 2321.280403075052, 2478.628205769131, 2735.534959056965, 12856.421461034275, 13512.932435337858, 14123.858761412357, 15942.840571594252, 16581.088040157785, 1539.780980284261, 1605.8233594304618, 1939.9860432658786, 1954.3550628292771, 1976.2292705844732, 112655.0, 114791.0, 126655.36672316672, 130894.34552827175, 133135.0, 9365.672201472917, 11707.473163707653, 11813.763724725457, 11891.643250702493, 12053.0960177987, 12397.442115104843, 14899.255037248095, 14927.850721492863, 14933.328000240015, 14940.626484337978, 7186.964065179745, 8450.788730281669, 8730.650773969097, 8829.381943264038, 8839.718240855169, 8551.914480855112, 8552.401331906707, 8608.827823443497, 8761.167689069529, 8781.20969112783, 3614.6746792788776, 3777.508923839883, 4658.231391820379, 4663.044075964419, 4704.976475117603, 1976.4762337980446, 1996.0, 2001.599680063993, 2008.4777957730803, 2046.5190680190144, 897.3449381951082, 959.5681943125621, 998.2712619787595, 1013.8681971343678, 1060.5439660945867, 21700.891495542422, 22490.550188996127, 22569.210077647203, 22598.209062682727, 22658.66012009821, 862.7109918177356, 914.4056363363867, 928.758522784081, 937.2174234514121, 947.6493697332031, 11621.53513859453, 11799.056075513938, 11887.762244755057, 11934.283942963277, 12032.338221397733, 617428.0, 622711.0, 623231.0, 631483.0, 643318.0, 139546.30226849005, 150403.0, 152271.0, 152689.0, 153885.0, 827.4828232354778, 881.2817553693719, 1009.2430676992255, 1011.6358111079858, 1026.1841835740604, 19722.90138549298, 20376.0830762619, 20558.794412056286, 20575.0, 20613.793862061186, 57752.42247577639, 59572.0, 59676.80646387135, 60366.0, 61295.38704612897, 85633.0, 86500.13499864921, 86631.0, 86932.56533717291, 87733.68399473885, 7173.282671732785, 8054.516728996279, 8075.676972921017, 8146.796330091795, 8372.204640559137, 11313.321200727984, 11334.603288885179, 13515.256660883746, 13973.301334933416, 14238.216898070705, 10635.734106647396, 11207.775844483227, 11591.0, 11597.18819682614, 11775.116866234895, 9273.0, 11463.828042579202, 11752.823707644564, 11771.882281177079, 11966.341851198267, 11542.82685759731, 11623.244489108181, 11943.761124777282, 12017.759644807229, 12053.096017798876, 7563.239417612642, 7601.619919004138, 7679.155292917663, 7778.377729781717, 7919.208079192034, 9823.557939892578, 10868.782624347627, 11787.646370608896, 11850.0, 12138.0], "value": 9842.242121764348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.8983671143021, 1522.9314680839361, 1691.0868131209147, 1873.297513432463, 1892.4511891551451, 7253.564786112837, 7932.167122452146, 8374.371922105844, 8933.4193277437, 8974.641014359426, 8594.312455003601, 8783.780405489866, 8785.824283514326, 8790.077041910587, 8793.03276639569, 2314.9421264468356, 2348.8590684558894, 2352.6706261123454, 2355.7173139223232, 2399.748026457223, 2131.3925531223604, 2306.423394151462, 2364.6216605343147, 2373.121944880388, 2380.262118743195, 1968.1536939116174, 2352.6118190498546, 2355.458244603742, 2355.4817940053163, 2358.740538540759, 1895.5924476237606, 2202.0421116814236, 2205.2943058221376, 2214.1918199856937, 2221.3447033125185, 2022.403390999644, 2275.93031275302, 2323.488832456857, 2325.104834638659, 2335.719713634358, 7537.623118844036, 7833.1775163608145, 8602.709593560954, 8846.5134417607, 8848.115188481164, 5173.3016042834115, 5280.419153893069, 5341.011912796145, 5348.331458567679, 5355.116405793039, 3501.3172431375892, 3564.1802385451233, 3667.743257971943, 3692.8153592320277, 3713.1088538750773, 933.7292185266265, 1081.9891801081967, 1099.6755956992627, 1102.2614848051824, 1113.604670342025, 11405.942970285096, 11426.771464570746, 11590.884091159065, 11591.884081159249, 11623.244489108265, 4566.383538222364, 4705.200115980223, 4789.066132104276, 4811.975940120277, 4813.4945830687975, 9745.02549745034, 9839.950800245953, 9849.310548261554, 9851.113399794052, 9856.45789481571, 5299.231611416323, 5304.124819404755, 5316.362036555561, 5319.0957537218765, 5328.4671532846405, 4398.73607583546, 4743.312219728189, 4854.732989685531, 4880.194767863263, 4896.045271172158, 3829.310724069694, 3902.35611124167, 3979.0, 3987.003249187703, 4012.257732319472, 1087.9456027198607, 1260.3698150924538, 1272.1158794637822, 1275.9681007974875, 1279.7120647854158, 908.7864351877304, 919.8758167647416, 922.4096578189964, 940.3370623710268, 950.0879156010169, 5753.33836608787, 5951.732172052268, 6095.146679464879, 6167.876642467126, 6183.288921773964, 415.20695471649003, 426.9380939763717, 440.5308346610849, 448.0, 449.2519954276159, 3583.3191693578137, 3634.1278093257956, 3964.266610677034, 4017.678585713136, 4080.755154690669, 9129.954350228207, 10208.795824083625, 10668.62659806903, 10698.62554810578, 10708.839367409495, 10551.736206594896, 10572.52423640938, 10603.469826508797, 10728.195385346131, 10859.40273284961, 6934.341237582422, 6968.930310696828, 8053.919460805317, 8213.671453141927, 8236.794080148044, 5951.464368206882, 5959.851003724768, 5966.642001479925, 5971.641701497924, 5974.103884417372, 8442.113578074459, 9662.323637345318, 9811.607535698493, 9913.603455861685, 10141.188704903738, 9910.75223119399, 10090.949545252226, 10220.744481388025, 10237.078662920372, 10260.743481413025, 6797.252302246848, 7395.149557800922, 7480.289372509603, 7520.172780993977, 7616.04799400075, 8406.87389689143, 8482.066972633129, 8492.108328625405, 8498.575071246536, 8504.53225072627, 7360.96319518399, 7485.5508669480005, 7500.1374841893885, 7545.283198096172, 7579.166291707797, 7128.786136415916, 7292.96353518229, 7302.634868256672, 7350.301721336465, 7467.626618669154, 6055.757769689163, 6975.546589471668, 7019.789406317818, 7065.293470652894, 7074.858502830018, 4926.655134140576, 4984.75076246179, 5017.924731129109, 5060.84817455477, 5154.690718556899, 5018.924716129188, 5035.16919708244, 5156.948430515797, 5166.819161329336, 5224.817131400383], "value": 4456.203667940337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.4547813675879, 298.18892612095095, 300.43068385409634, 310.95674013684095, 314.3210664963679, 4525.637948964083, 4793.952060479394, 5112.182050871861, 5378.650387724795, 5665.971670141648, 4195.349720793282, 5386.245925570413, 5572.108462645978, 5586.832395028156, 5617.550595952324, 3752.8311225994894, 3922.27419935229, 4223.028703398205, 4269.551697071809, 4309.956900430987, 3425.075229687995, 3910.7849068301234, 4230.344296634026, 4252.00155926714, 4372.825086996516, 3464.861405543775, 4200.70595058346, 4201.159768046387, 4216.59942305482, 4227.704060715751, 3316.7014968652816, 4222.2611043067645, 4230.0, 4242.469691288589, 4256.489221293434, 3019.8037127586636, 3451.430513965193, 3618.294432585647, 3631.092226943264, 3645.76302540334, 4859.708417494961, 5027.396712394536, 5553.361363443215, 5555.8888822223735, 5581.274434323553, 4851.902961940777, 4870.878228044292, 4878.560929516325, 4900.142475066885, 4906.969536397361, 4939.259111133323, 5880.882382352372, 5931.703414829241, 5943.108533719934, 6037.184980027684, 3318.4569175333586, 3959.881203563869, 3976.443297938291, 4003.6396724294664, 4120.835166593332, 4992.700437973734, 5159.406668233164, 6214.409631085085, 6272.247330320391, 6352.428281454645, 3787.6401741834484, 4024.6981476389387, 4035.7198183026494, 4048.3117869962175, 4082.3264161413626, 4114.794260286973, 4116.938245926313, 4124.0, 4139.958600414017, 4140.855070072594, 4874.8050077997195, 4882.975585122052, 4887.584555312838, 4893.73084480357, 4918.385201849769, 4822.565969062731, 5637.548996080303, 5815.41845815415, 6090.442014353982, 6092.603980741238, 1123.9943800280946, 1247.5508816825936, 1317.7298653775954, 1372.3344178073626, 1393.7839634856614, 720.765751130874, 780.9101953275332, 819.496009953874, 865.731623196811, 869.7955980344741, 4410.360497727876, 4444.511103778582, 4577.040859656439, 4817.16947559925, 4828.106800241966, 4697.929531057037, 4895.31465594817, 5207.817726379559, 5259.947400526023, 5375.946240537544, 4095.4675892133832, 4703.623710103184, 4709.576138147583, 4743.881402964885, 4816.8554943351755, 3004.7896647234484, 3018.758499320049, 3163.9050828475183, 3263.640999490054, 3278.6229583597715, 6137.723802428902, 6369.585976911486, 6389.520785941073, 6398.2641996170105, 6425.518086143558, 4826.0830442215865, 5367.490088441592, 6093.573449858467, 6176.8764624707255, 6401.359864013654, 6374.298827129012, 6379.904301435482, 6403.871922561522, 6406.455451286693, 6426.260979987362, 5018.247262910447, 5135.897282054413, 5617.578681598815, 6142.051815128674, 6252.749890004349, 5156.948430515647, 5448.83653490396, 5999.280086389661, 6044.274687037584, 6121.632702037892, 5306.097963346163, 5666.583354161459, 6018.0, 6216.968915155395, 6492.610443373413, 3472.600650925176, 3559.110222444389, 3941.482529226211, 4004.619561141687, 4005.1989602079116, 5630.507915402503, 5681.77272909079, 5950.173667507899, 6059.545534085049, 6142.969285153546, 4805.035845427607, 5783.363829978614, 5939.287285525765, 6021.367756385692, 6069.817905462844, 5208.5312321891215, 5956.851078723066, 6000.459958603747, 6043.2748070231855, 6061.333253342217, 4842.0, 5227.843164705065, 5625.324961004706, 5803.854903627274, 5896.054302080389, 5308.442613525524, 5671.0, 6048.243969503812, 6062.120492766077, 6085.482733967662, 5395.541378982831, 5420.159875219348, 5884.293884733859, 5903.675297858659, 5932.911006334822], "value": 4194.512330911055, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.2376198063121, 700.5096432497247, 704.8097013806275, 716.3910675925464, 719.9496035277531, 14318.856811431882, 15762.133082680448, 16018.439354622591, 16136.838631613695, 16158.596035099128, 14608.0, 14614.342354594042, 14636.560903172895, 14738.778918316233, 14784.778228326557, 695.2595485807624, 863.0851297624538, 865.0614083719172, 873.10506730601, 874.2088409988938, 767.2404319723462, 773.2306355176607, 774.2760518914805, 851.8849955256054, 877.9078196789341, 867.7353407210799, 869.0310304011014, 913.7624217703411, 916.2669864108686, 917.0096296000337, 857.7726902370877, 880.2913654508119, 905.1943770044666, 916.3722849847876, 917.9219766319837, 686.0258433025067, 688.3460712323263, 688.7830333444949, 689.2590465249826, 696.7039008421401, 12706.491740330375, 14657.193854338007, 15123.621909452242, 15138.167400792952, 15145.621359465991, 14637.268136593128, 14730.337134828958, 14935.775963360558, 15077.849221507755, 15694.68610627781, 11884.702882427922, 12137.817932731015, 12319.384030798514, 12347.320897350643, 12399.380030998504, 3843.385058390644, 3859.3439115350457, 4079.2249472600406, 4097.180563887205, 4099.0162361033135, 107565.0, 122476.0, 122886.38556807248, 123839.14241286388, 124358.0, 11302.434878256054, 11448.54205831774, 11471.311721296748, 11472.0, 11746.765064698659, 23660.290191294287, 23739.287821365386, 23768.16811411627, 23777.286681399586, 24101.0, 8104.918950810416, 8209.630566624517, 8252.21603947624, 8288.046874609376, 8315.0, 3996.160806230724, 4235.89866634671, 4354.738715677069, 4360.629346505519, 4407.427034485497, 3603.0992251937014, 3713.5543734751463, 3745.4943582616543, 3746.400575907842, 3756.1924186300075, 659.6839305585388, 662.0532638327143, 662.6918482905376, 668.4518694670323, 668.6890595872942, 601.9668918209541, 660.2539130782282, 665.2416245480157, 689.0525527399825, 696.2445746365149, 8780.648774048967, 9183.311251656152, 9429.905700942903, 9638.566264518113, 9688.783915209602, 636.7166610858123, 642.5566359212129, 671.7548094945407, 674.4199988010307, 676.5839009009424, 4502.729836209773, 4664.463586687507, 4672.0, 4677.906441871143, 4705.294205869079, 161102.1944890268, 163954.0, 165811.0, 166555.0, 171384.0, 136336.0, 137720.31139844438, 138229.0, 140048.0, 147489.0, 105413.9458605404, 106663.93336066695, 108802.91197087927, 110886.0, 123343.0, 9381.390209636353, 9504.192143667866, 9812.116909478182, 9951.303408761607, 10159.187265018632, 59059.40940590539, 61034.38965610465, 61816.0, 62283.37716622776, 63664.68167659132, 83194.58402707947, 88175.0, 90052.64921026058, 91153.0, 91703.08296916945, 11206.159538034517, 11290.830637540608, 11514.36670983104, 11701.88298117042, 13118.475260989835, 14420.927895360455, 15091.698166036398, 15571.532854014398, 15791.526254212393, 15876.126813024932, 13670.163193273647, 13750.587482375544, 14035.00059592393, 14167.079139856289, 14371.92814035923, 13768.586942391745, 13826.723465530835, 14082.859171408154, 14159.0, 14255.075564799034, 13769.380377883219, 13804.792928105886, 13887.722245555235, 14103.506377276746, 14162.0, 9749.610015599297, 10086.596536138471, 11222.719432013939, 11499.425028748696, 11769.17615766888, 8671.956640216758, 10096.990300969845, 11423.687130731994, 11562.248453850472, 11823.23148995347], "value": 7968.231234263096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 108.0, 120.0, 117.0, 117.0, 115.0, 118.0, 118.0, 119.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 113.0, 136.0, 180.0, 141.0, 166.0, 148.0, 109.0, 155.0, 111.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 208.0, 206.0, 234.0, 195.0, 195.0, 196.0, 197.0, 196.0, 272.0], "value": 209.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 83.0, 75.0, 142.0, 59.0, 59.0, 59.0, 64.0, 136.0, 60.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 119.0, 71.0, 72.0, 76.0, 98.0, 95.0, 61.0, 119.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 90.0, 88.0, 86.0, 136.0, 132.0, 89.0, 85.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 106.0, 152.0, 95.0, 96.0, 131.0, 134.0, 131.0], "value": 113.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 102.0, 90.0, 91.0, 127.0, 145.0, 147.0, 92.0, 91.0, 92.0], "value": 108.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 77.0, 83.0, 84.0, 66.0, 56.0, 57.0, 55.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 106.0, 102.0, 101.0, 85.0, 75.0, 96.0, 88.0, 66.0, 95.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 103.0, 112.0, 85.0, 85.0, 83.0, 85.0, 90.0, 110.0, 87.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 134.0, 160.0, 180.0, 148.0, 155.0, 137.0, 151.0, 135.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 166.0, 168.0, 168.0, 168.0, 168.0, 168.0, 231.0, 166.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 70.0, 68.0, 67.0, 69.0, 65.0, 67.0, 70.0], "value": 68.3, "unit": "score"}]}]} 11:44:29 INFO - Return code: 0 11:44:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:29 ERROR - # TBPL SUCCESS # 11:44:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:44:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:44:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:44:29 INFO - 2016-08-12 11:44:29.625 screenresolution[1702:10668] starting screenresolution argv=screenresolution get 11:44:29 INFO - 2016-08-12 11:44:29.628 screenresolution[1702:10668] Display 0: 1600x1200x32@60 11:44:29 INFO - 2016-08-12 11:44:29.634 screenresolution[1703:10671] starting screenresolution argv=screenresolution list 11:44:29 INFO - Available Modes on Display 0 11:44:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:44:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:44:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:44:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:44:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:44:29 INFO - Intel Iris: 11:44:29 INFO - Chipset Model: Intel Iris 11:44:29 INFO - Type: GPU 11:44:29 INFO - Bus: Built-In 11:44:29 INFO - VRAM (Dynamic, Max): 1536 MB 11:44:29 INFO - Vendor: Intel (0x8086) 11:44:29 INFO - Device ID: 0x0a2e 11:44:29 INFO - Revision ID: 0x0009 11:44:29 INFO - Displays: 11:44:29 INFO - Display: 11:44:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:44:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:44:29 INFO - Display Serial Number: 1600x1200 60 11:44:29 INFO - Main Display: Yes 11:44:29 INFO - Mirror: Off 11:44:29 INFO - Online: Yes 11:44:29 INFO - Rotation: Supported 11:44:29 INFO - Return code: 0 11:44:29 INFO - Running post-action listener: _resource_record_post_action 11:44:29 INFO - [mozharness: 2016-08-12 18:44:29.873761Z] Finished run-tests step (success) 11:44:29 INFO - Running post-run listener: _resource_record_post_run 11:44:29 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37667840; Write bytes: 705141248; Read time: 362; Write time: 2009 11:44:29 INFO - TinderboxPrint: CPU usage
54.3% 11:44:29 INFO - TinderboxPrint: I/O read bytes / time
37,667,840 / 362 11:44:29 INFO - TinderboxPrint: I/O write bytes / time
705,141,248 / 2,009 11:44:29 INFO - TinderboxPrint: CPU idle
2,212.6 (45.7%) 11:44:29 INFO - TinderboxPrint: CPU system
977.1 (20.2%) 11:44:29 INFO - TinderboxPrint: CPU user
1,652.0 (34.1%) 11:44:29 INFO - TinderboxPrint: Swap in / out
441,376,768 / 0 11:44:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397326848; Write bytes: 391366144; Read time: 29375; Write time: 696 11:44:29 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36267008; Write bytes: 297980928; Read time: 350; Write time: 1212 11:44:30 INFO - Running post-run listener: _upload_blobber_files 11:44:30 INFO - Blob upload gear active. 11:44:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:31 INFO - (blobuploader) - INFO - Done attempting. 11:44:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:44:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:44:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:32 INFO - (blobuploader) - INFO - Done attempting. 11:44:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:36 INFO - (blobuploader) - INFO - Done attempting. 11:44:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:36 INFO - Return code: 0 11:44:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68da5bed9ef9b49d0364c175a4b1f81be6599b95aad0c86a7764f32fd863872b3637b70a7bcc10c060c6128f6f616ee22a723ef674c38757718c35514b8f090f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72c2554d438f980ccd7f2c5a34e878fc429d81bc101e3e86ef88abe4370381017dcbfba4f601c87be873d773e715cc5df77e5a3310d5d47197fc4ad0de415cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c75e0ff6a8d8f4db96e1070500af00469a7d13251d5c84929b8a30ab3559385cc229b18635974cb6ecc0e44c065933c59427e8b28f7302445de171ab00e2a9b"} 11:44:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:36 INFO - Contents: 11:44:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68da5bed9ef9b49d0364c175a4b1f81be6599b95aad0c86a7764f32fd863872b3637b70a7bcc10c060c6128f6f616ee22a723ef674c38757718c35514b8f090f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72c2554d438f980ccd7f2c5a34e878fc429d81bc101e3e86ef88abe4370381017dcbfba4f601c87be873d773e715cc5df77e5a3310d5d47197fc4ad0de415cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c75e0ff6a8d8f4db96e1070500af00469a7d13251d5c84929b8a30ab3559385cc229b18635974cb6ecc0e44c065933c59427e8b28f7302445de171ab00e2a9b"} 11:44:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:36 INFO - Copying logs to upload dir... 11:44:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.096360 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-12 11:44:36.555503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 11:44:36.559539) ========= 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.KpH0w497eZ/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.NftA0a1EZp/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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/68da5bed9ef9b49d0364c175a4b1f81be6599b95aad0c86a7764f32fd863872b3637b70a7bcc10c060c6128f6f616ee22a723ef674c38757718c35514b8f090f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72c2554d438f980ccd7f2c5a34e878fc429d81bc101e3e86ef88abe4370381017dcbfba4f601c87be873d773e715cc5df77e5a3310d5d47197fc4ad0de415cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c75e0ff6a8d8f4db96e1070500af00469a7d13251d5c84929b8a30ab3559385cc229b18635974cb6ecc0e44c065933c59427e8b28f7302445de171ab00e2a9b"} build_url:https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/S4ZD3czmSLiv6mYCBCTV9A/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/68da5bed9ef9b49d0364c175a4b1f81be6599b95aad0c86a7764f32fd863872b3637b70a7bcc10c060c6128f6f616ee22a723ef674c38757718c35514b8f090f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/72c2554d438f980ccd7f2c5a34e878fc429d81bc101e3e86ef88abe4370381017dcbfba4f601c87be873d773e715cc5df77e5a3310d5d47197fc4ad0de415cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c75e0ff6a8d8f4db96e1070500af00469a7d13251d5c84929b8a30ab3559385cc229b18635974cb6ecc0e44c065933c59427e8b28f7302445de171ab00e2a9b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 11:44:36.592960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:44:36.593350) ========= 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.KpH0w497eZ/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.NftA0a1EZp/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005166 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:44:36.645043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 11:44:36.645532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 11:44:36.646321) ========= ========= Total master_lag: 0.19 =========