builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0277 starttime: 1471024193.92 results: success (0) buildid: 20160812084117 builduid: ab3186a8f2b74e349e2c936c9ceb90ca revision: a977a28fed2dfed886abd85ab641d83bb3a3a279 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:53.925162) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:53.925672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:53.925952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:53.953878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:53.954349) ========= 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.soUW6aUDzm/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.W6qrWB3QYa/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 10:49:53-- 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% 18.6M=0.001s 2016-08-12 10:49:54 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084625 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:54.061585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:54.061909) ========= 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.soUW6aUDzm/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.W6qrWB3QYa/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.025953 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:54.110823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-12 10:49:54.111239) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a977a28fed2dfed886abd85ab641d83bb3a3a279 --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 a977a28fed2dfed886abd85ab641d83bb3a3a279 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.soUW6aUDzm/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.W6qrWB3QYa/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 10:49:54,194 truncating revision to first 12 chars 2016-08-12 10:49:54,194 Setting DEBUG logging. 2016-08-12 10:49:54,194 attempt 1/10 2016-08-12 10:49:54,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a977a28fed2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 10:49:55,447 unpacking tar archive at: autoland-a977a28fed2d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.533401 ========= master_lag: 0.74 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-12 10:49:56.385156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:56.385487) ========= script_repo_revision: a977a28fed2dfed886abd85ab641d83bb3a3a279 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:56.385910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:56.386173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 10:49:56.406175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2016-08-12 10:49:56.406811) ========= /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.soUW6aUDzm/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.W6qrWB3QYa/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:49:56 INFO - MultiFileLogger online at 20160812 10:49:56 in /builds/slave/test 10:49:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:49:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:49:56 INFO - {'append_to_log': False, 10:49:56 INFO - 'base_work_dir': '/builds/slave/test', 10:49:56 INFO - 'blob_upload_branch': 'Autoland', 10:49:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:49:56 INFO - 'branch': 'Autoland', 10:49:56 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:56 INFO - 'config_files': ('talos/mac_config.py',), 10:49:56 INFO - 'default_actions': ('clobber', 10:49:56 INFO - 'read-buildbot-config', 10:49:56 INFO - 'download-and-extract', 10:49:56 INFO - 'populate-webroot', 10:49:56 INFO - 'create-virtualenv', 10:49:56 INFO - 'install', 10:49:56 INFO - 'run-tests'), 10:49:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:56 INFO - 'download_minidump_stackwalk': True, 10:49:56 INFO - 'download_symbols': 'ondemand', 10:49:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:56 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:56 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:56 INFO - 'installer_path': 'installer.exe', 10:49:56 INFO - 'log_level': 'info', 10:49:56 INFO - 'log_name': 'talos', 10:49:56 INFO - 'log_to_console': True, 10:49:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:49:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:49:56 INFO - 'opt_config_files': (), 10:49:56 INFO - 'pip_index': False, 10:49:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:56 INFO - 'cmd': ('bash', 10:49:56 INFO - '-c', 10:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:56 INFO - 'enabled': True, 10:49:56 INFO - 'halt_on_failure': False, 10:49:56 INFO - 'name': 'check_screen_resolution'},), 10:49:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:56 INFO - 'cmd': ('bash', 10:49:56 INFO - '-c', 10:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:56 INFO - 'enabled': True, 10:49:56 INFO - 'halt_on_failure': False, 10:49:56 INFO - 'name': 'check_screen_resolution'},), 10:49:56 INFO - 'run_cmd_checks_enabled': True, 10:49:56 INFO - 'sps_profile': False, 10:49:56 INFO - 'sps_profile_interval': 0, 10:49:56 INFO - 'suite': 'dromaeojs-e10s', 10:49:56 INFO - 'system_bits': '32', 10:49:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:56 INFO - 'title': 't-yosemite-r7-0277', 10:49:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:56 INFO - 'use_talos_json': True, 10:49:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:49:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:56 INFO - 'work_dir': 'build'} 10:49:56 INFO - [mozharness: 2016-08-12 17:49:56.605335Z] Running clobber step. 10:49:56 INFO - Running pre-action listener: _resource_record_pre_action 10:49:56 INFO - Running main action method: clobber 10:49:56 INFO - rmtree: /builds/slave/test/build 10:49:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:49:58 INFO - Running post-action listener: _resource_record_post_action 10:49:58 INFO - [mozharness: 2016-08-12 17:49:58.567593Z] Finished clobber step (success) 10:49:58 INFO - [mozharness: 2016-08-12 17:49:58.567788Z] Running read-buildbot-config step. 10:49:58 INFO - Running pre-action listener: _resource_record_pre_action 10:49:58 INFO - Running main action method: read_buildbot_config 10:49:58 INFO - Using buildbot properties: 10:49:58 INFO - { 10:49:58 INFO - "project": "", 10:49:58 INFO - "product": "firefox", 10:49:58 INFO - "script_repo_revision": "production", 10:49:58 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 10:49:58 INFO - "repository": "", 10:49:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 10:49:58 INFO - "buildid": "20160812084117", 10:49:58 INFO - "pgo_build": "False", 10:49:58 INFO - "basedir": "/builds/slave/test", 10:49:58 INFO - "buildnumber": 113, 10:49:58 INFO - "slavename": "t-yosemite-r7-0277", 10:49:58 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:49:58 INFO - "platform": "yosemite_r7", 10:49:58 INFO - "scheduler": "tests-autoland-macosx64-talos", 10:49:58 INFO - "branch": "autoland", 10:49:58 INFO - "repo_path": "integration/autoland", 10:49:58 INFO - "revision": "a977a28fed2dfed886abd85ab641d83bb3a3a279", 10:49:58 INFO - "stage_platform": "macosx64", 10:49:58 INFO - "builduid": "ab3186a8f2b74e349e2c936c9ceb90ca", 10:49:58 INFO - "slavebuilddir": "test" 10:49:58 INFO - } 10:49:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:49:58 INFO - Running post-action listener: _resource_record_post_action 10:49:58 INFO - [mozharness: 2016-08-12 17:49:58.573189Z] Finished read-buildbot-config step (success) 10:49:58 INFO - [mozharness: 2016-08-12 17:49:58.573332Z] Running download-and-extract step. 10:49:58 INFO - Running pre-action listener: _resource_record_pre_action 10:49:58 INFO - Running main action method: download_and_extract 10:49:58 INFO - mkdir: /builds/slave/test/build/tests 10:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:58 INFO - trying https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:49:58 INFO - Downloading https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:49:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 10:49:59 INFO - Downloaded 1199 bytes. 10:49:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:49:59 INFO - Using the following test package requirements: 10:49:59 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:49:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:49:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:49:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'jsshell-mac.zip'], 10:49:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:49:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:49:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:49:59 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:49:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:49:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:49:59 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:49:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:59 INFO - trying https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:49:59 INFO - Downloading https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:49:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:50:00 INFO - Downloaded 16328714 bytes. 10:50:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:50:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:07 INFO - trying https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:50:07 INFO - Downloading https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:50:27 INFO - Downloaded 16328714 bytes. 10:50:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:34 INFO - trying https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:50:34 INFO - Downloading https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:51:05 INFO - Downloaded 14413719 bytes. 10:51:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:05 INFO - trying https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:51:05 INFO - Downloading https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 10:51:09 INFO - Downloaded 110965372 bytes. 10:51:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:51:09 INFO - mkdir: /builds/slave/test/properties 10:51:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:09 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:09 INFO - Contents: 10:51:09 INFO - build_url:https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - Running post-action listener: set_extra_try_arguments 10:51:09 INFO - [mozharness: 2016-08-12 17:51:09.662405Z] Finished download-and-extract step (success) 10:51:09 INFO - [mozharness: 2016-08-12 17:51:09.662533Z] Running populate-webroot step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: populate_webroot 10:51:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:09 INFO - '--tppagecycles', 10:51:09 INFO - '7'], 10:51:09 INFO - 'tests': ['tsvgm']}}, 10:51:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['damp', 'tps']}, 10:51:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'tests': ['damp', 'tps']}, 10:51:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['dromaeo_dom']}, 10:51:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['basic_compositor_video']}, 10:51:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tsvgx', 10:51:09 INFO - 'tsvgr_opacity', 10:51:09 INFO - 'tart', 10:51:09 INFO - 'tscrollx', 10:51:09 INFO - 'cart']}, 10:51:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:09 INFO - 'tsvgr_opacity', 10:51:09 INFO - 'tart', 10:51:09 INFO - 'tscrollx', 10:51:09 INFO - 'cart']}, 10:51:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tp5o']}, 10:51:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'tests': ['tp5o']}, 10:51:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s', 10:51:09 INFO - '--xperf_path', 10:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:09 INFO - 'tests': ['tp5n']}, 10:51:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--xperf_path', 10:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:09 INFO - 'tests': ['tp5n']}}, 10:51:09 INFO - 'talos.zip': {'path': '', 10:51:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - [mozharness: 2016-08-12 17:51:09.681608Z] Finished populate-webroot step (success) 10:51:09 INFO - [mozharness: 2016-08-12 17:51:09.681731Z] Running create-virtualenv step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: create_virtualenv 10:51:09 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:51:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:09 INFO - Using real prefix '/tools/python27' 10:51:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:10 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:13 INFO - Installing pip.................done. 10:51:13 INFO - Return code: 0 10:51:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:13 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:13 INFO - 'HOME': '/Users/cltbld', 10:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:13 INFO - 'LOGNAME': 'cltbld', 10:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:13 INFO - 'MOZ_NO_REMOTE': '1', 10:51:13 INFO - 'NO_EM_RESTART': '1', 10:51:13 INFO - 'PAGER': '/bin/cat', 10:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:13 INFO - 'PWD': '/builds/slave/test', 10:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:13 INFO - 'SHELL': '/bin/bash', 10:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:13 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:13 INFO - 'USER': 'cltbld', 10:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:13 INFO - 'XPC_FLAGS': '0x0', 10:51:13 INFO - 'XPC_SERVICE_NAME': '0', 10:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:51:13 INFO - Cleaning up... 10:51:13 INFO - Return code: 0 10:51:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:13 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:13 INFO - 'HOME': '/Users/cltbld', 10:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:13 INFO - 'LOGNAME': 'cltbld', 10:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:13 INFO - 'MOZ_NO_REMOTE': '1', 10:51:13 INFO - 'NO_EM_RESTART': '1', 10:51:13 INFO - 'PAGER': '/bin/cat', 10:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:13 INFO - 'PWD': '/builds/slave/test', 10:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:13 INFO - 'SHELL': '/bin/bash', 10:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:13 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:13 INFO - 'USER': 'cltbld', 10:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:13 INFO - 'XPC_FLAGS': '0x0', 10:51:13 INFO - 'XPC_SERVICE_NAME': '0', 10:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:13 INFO - Downloading/unpacking psutil>=3.1.1 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:17 INFO - Installing collected packages: psutil 10:51:17 INFO - Running setup.py install for psutil 10:51:17 INFO - building 'psutil._psutil_osx' extension 10:51:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:51:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:51:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:51:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:51:18 INFO - building 'psutil._psutil_posix' extension 10:51:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:51:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:51:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:51:18 INFO - ^ 10:51:18 INFO - 1 warning generated. 10:51:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:51:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:18 INFO - Successfully installed psutil 10:51:18 INFO - Cleaning up... 10:51:18 INFO - Return code: 0 10:51:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:51: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 mozsystemmonitor==0.3 10:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:18 INFO - 'HOME': '/Users/cltbld', 10:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:18 INFO - 'LOGNAME': 'cltbld', 10:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:18 INFO - 'MOZ_NO_REMOTE': '1', 10:51:18 INFO - 'NO_EM_RESTART': '1', 10:51:18 INFO - 'PAGER': '/bin/cat', 10:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:18 INFO - 'PWD': '/builds/slave/test', 10:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:18 INFO - 'SHELL': '/bin/bash', 10:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:18 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:18 INFO - 'USER': 'cltbld', 10:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:18 INFO - 'XPC_FLAGS': '0x0', 10:51:18 INFO - 'XPC_SERVICE_NAME': '0', 10:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:21 INFO - Installing collected packages: mozsystemmonitor 10:51:21 INFO - Running setup.py install for mozsystemmonitor 10:51:21 INFO - Successfully installed mozsystemmonitor 10:51:21 INFO - Cleaning up... 10:51:21 INFO - Return code: 0 10:51:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:21 INFO - 'HOME': '/Users/cltbld', 10:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:21 INFO - 'LOGNAME': 'cltbld', 10:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:21 INFO - 'MOZ_NO_REMOTE': '1', 10:51:21 INFO - 'NO_EM_RESTART': '1', 10:51:21 INFO - 'PAGER': '/bin/cat', 10:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:21 INFO - 'PWD': '/builds/slave/test', 10:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:21 INFO - 'SHELL': '/bin/bash', 10:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:21 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:21 INFO - 'USER': 'cltbld', 10:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:21 INFO - 'XPC_FLAGS': '0x0', 10:51:21 INFO - 'XPC_SERVICE_NAME': '0', 10:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:21 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:24 INFO - warning: no files found matching '*.txt' 10:51:24 INFO - no previously-included directories found matching 'build' 10:51:24 INFO - no previously-included directories found matching 'dist' 10:51:24 INFO - no previously-included directories found matching '.git*' 10:51:24 INFO - Installing collected packages: jsonschema, functools32 10:51:24 INFO - Running setup.py install for functools32 10:51:25 INFO - warning: no files found matching '*.txt' 10:51:25 INFO - no previously-included directories found matching 'build' 10:51:25 INFO - no previously-included directories found matching 'dist' 10:51:25 INFO - no previously-included directories found matching '.git*' 10:51:25 INFO - Successfully installed jsonschema functools32 10:51:25 INFO - Cleaning up... 10:51:25 INFO - Return code: 0 10:51:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:25 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:25 INFO - 'HOME': '/Users/cltbld', 10:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:25 INFO - 'LOGNAME': 'cltbld', 10:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:25 INFO - 'MOZ_NO_REMOTE': '1', 10:51:25 INFO - 'NO_EM_RESTART': '1', 10:51:25 INFO - 'PAGER': '/bin/cat', 10:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:25 INFO - 'PWD': '/builds/slave/test', 10:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:25 INFO - 'SHELL': '/bin/bash', 10:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:25 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:25 INFO - 'USER': 'cltbld', 10:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:25 INFO - 'XPC_FLAGS': '0x0', 10:51:25 INFO - 'XPC_SERVICE_NAME': '0', 10:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:51:25 INFO - Cleaning up... 10:51:25 INFO - Return code: 0 10:51:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:25 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:25 INFO - 'HOME': '/Users/cltbld', 10:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:25 INFO - 'LOGNAME': 'cltbld', 10:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:25 INFO - 'MOZ_NO_REMOTE': '1', 10:51:25 INFO - 'NO_EM_RESTART': '1', 10:51:25 INFO - 'PAGER': '/bin/cat', 10:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:25 INFO - 'PWD': '/builds/slave/test', 10:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:25 INFO - 'SHELL': '/bin/bash', 10:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:25 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:25 INFO - 'USER': 'cltbld', 10:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:25 INFO - 'XPC_FLAGS': '0x0', 10:51:25 INFO - 'XPC_SERVICE_NAME': '0', 10:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:29 INFO - Downloading docopt-0.6.1.tar.gz 10:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:29 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:29 INFO - Running setup.py install for blobuploader 10:51:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:29 INFO - Running setup.py install for requests 10:51:30 INFO - Running setup.py install for docopt 10:51:30 INFO - Successfully installed blobuploader requests docopt 10:51:30 INFO - Cleaning up... 10:51:30 INFO - Return code: 0 10:51:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:30 INFO - 'HOME': '/Users/cltbld', 10:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:30 INFO - 'LOGNAME': 'cltbld', 10:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:30 INFO - 'MOZ_NO_REMOTE': '1', 10:51:30 INFO - 'NO_EM_RESTART': '1', 10:51:30 INFO - 'PAGER': '/bin/cat', 10:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:30 INFO - 'PWD': '/builds/slave/test', 10:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:30 INFO - 'SHELL': '/bin/bash', 10:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:30 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:30 INFO - 'USER': 'cltbld', 10:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:30 INFO - 'XPC_FLAGS': '0x0', 10:51:30 INFO - 'XPC_SERVICE_NAME': '0', 10:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:30 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-pM8WNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:30 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-n3UXrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:30 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-OfXhLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:30 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3p6Peq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:30 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-8GcemH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-4xxZMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3c3fWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-HoXzlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-1LvOqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-38aZ9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qy6xCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-PZCaCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Ah7R82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:31 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-yjRpqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:32 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-a9_quU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:32 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-loyUc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:32 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-nIIsyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:32 INFO - Running setup.py install for manifestparser 10:51:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:32 INFO - Running setup.py install for mozcrash 10:51:32 INFO - Running setup.py install for mozdebug 10:51:32 INFO - Running setup.py install for mozdevice 10:51:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:32 INFO - Running setup.py install for mozfile 10:51:33 INFO - Running setup.py install for mozhttpd 10:51:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Running setup.py install for mozinfo 10:51:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Running setup.py install for mozInstall 10:51:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Running setup.py install for mozleak 10:51:33 INFO - Running setup.py install for mozlog 10:51:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Running setup.py install for moznetwork 10:51:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Running setup.py install for mozprocess 10:51:34 INFO - Running setup.py install for mozprofile 10:51:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:34 INFO - Running setup.py install for mozrunner 10:51:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:34 INFO - Running setup.py install for mozscreenshot 10:51:34 INFO - Running setup.py install for moztest 10:51:34 INFO - Running setup.py install for mozversion 10:51:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:34 INFO - Cleaning up... 10:51:34 INFO - Return code: 0 10:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:34 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:34 INFO - 'HOME': '/Users/cltbld', 10:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:34 INFO - 'LOGNAME': 'cltbld', 10:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:34 INFO - 'MOZ_NO_REMOTE': '1', 10:51:34 INFO - 'NO_EM_RESTART': '1', 10:51:34 INFO - 'PAGER': '/bin/cat', 10:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:34 INFO - 'PWD': '/builds/slave/test', 10:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:34 INFO - 'SHELL': '/bin/bash', 10:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:34 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:34 INFO - 'USER': 'cltbld', 10:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:34 INFO - 'XPC_FLAGS': '0x0', 10:51:34 INFO - 'XPC_SERVICE_NAME': '0', 10:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3Z8SM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-wo8IyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-53Wrua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-esc7kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-z3IvS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-xHOHqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-kS_bjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-1yitCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-g5WCgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-99wR7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5i7jTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-mCKdVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-AXmK0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-h_mXcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3wHOJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-J1b10x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-M19kep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:39 INFO - Downloading blessings-1.6.tar.gz 10:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:39 INFO - Installing collected packages: blessings 10:51:39 INFO - Running setup.py install for blessings 10:51:39 INFO - Successfully installed blessings 10:51:39 INFO - Cleaning up... 10:51:39 INFO - Return code: 0 10:51:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:40 INFO - Reading from file tmpfile_stdout 10:51:40 INFO - Current package versions: 10:51:40 INFO - blessings == 1.6 10:51:40 INFO - blobuploader == 1.2.4 10:51:40 INFO - docopt == 0.6.1 10:51:40 INFO - functools32 == 3.2.3-2 10:51:40 INFO - jsonschema == 2.5.1 10:51:40 INFO - manifestparser == 1.1 10:51:40 INFO - mozInstall == 1.12 10:51:40 INFO - mozcrash == 0.17 10:51:40 INFO - mozdebug == 0.1 10:51:40 INFO - mozdevice == 0.48 10:51:40 INFO - mozfile == 1.2 10:51:40 INFO - mozhttpd == 0.7 10:51:40 INFO - mozinfo == 0.9 10:51:40 INFO - mozleak == 0.1 10:51:40 INFO - mozlog == 3.3 10:51:40 INFO - moznetwork == 0.27 10:51:40 INFO - mozprocess == 0.23 10:51:40 INFO - mozprofile == 0.28 10:51:40 INFO - mozrunner == 6.12 10:51:40 INFO - mozscreenshot == 0.1 10:51:40 INFO - mozsystemmonitor == 0.3 10:51:40 INFO - moztest == 0.7 10:51:40 INFO - mozversion == 1.4 10:51:40 INFO - psutil == 3.1.1 10:51:40 INFO - requests == 1.2.3 10:51:40 INFO - wsgiref == 0.1.2 10:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:40 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:40 INFO - 'HOME': '/Users/cltbld', 10:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:40 INFO - 'LOGNAME': 'cltbld', 10:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:40 INFO - 'MOZ_NO_REMOTE': '1', 10:51:40 INFO - 'NO_EM_RESTART': '1', 10:51:40 INFO - 'PAGER': '/bin/cat', 10:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:40 INFO - 'PWD': '/builds/slave/test', 10:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:40 INFO - 'SHELL': '/bin/bash', 10:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:40 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:40 INFO - 'USER': 'cltbld', 10:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:40 INFO - 'XPC_FLAGS': '0x0', 10:51:40 INFO - 'XPC_SERVICE_NAME': '0', 10:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:51:40 INFO - Cleaning up... 10:51:40 INFO - Return code: 0 10:51:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:40 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 0x10dcfca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd91618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918560ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, '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.soUW6aUDzm/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.W6qrWB3QYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:40 INFO - 'HOME': '/Users/cltbld', 10:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:40 INFO - 'LOGNAME': 'cltbld', 10:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:40 INFO - 'MOZ_NO_REMOTE': '1', 10:51:40 INFO - 'NO_EM_RESTART': '1', 10:51:40 INFO - 'PAGER': '/bin/cat', 10:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:40 INFO - 'PWD': '/builds/slave/test', 10:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:40 INFO - 'SHELL': '/bin/bash', 10:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:51:40 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:40 INFO - 'USER': 'cltbld', 10:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:40 INFO - 'XPC_FLAGS': '0x0', 10:51:40 INFO - 'XPC_SERVICE_NAME': '0', 10:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:40 INFO - Cleaning up... 10:51:40 INFO - Return code: 0 10:51:40 INFO - Running post-action listener: _resource_record_post_action 10:51:40 INFO - Running post-action listener: _start_resource_monitoring 10:51:40 INFO - Starting resource monitoring. 10:51:40 INFO - [mozharness: 2016-08-12 17:51:40.698049Z] Finished create-virtualenv step (success) 10:51:40 INFO - [mozharness: 2016-08-12 17:51:40.699031Z] Running install step. 10:51:40 INFO - Running pre-action listener: _resource_record_pre_action 10:51:40 INFO - Running main action method: install 10:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:40 INFO - Reading from file tmpfile_stdout 10:51:40 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:41 INFO - Reading from file tmpfile_stdout 10:51:41 INFO - Output received: 10:51:41 INFO - Usage: mozinstall [options] installer 10:51:41 INFO - Options: 10:51:41 INFO - -h, --help show this help message and exit 10:51:41 INFO - -d DEST, --destination=DEST 10:51:41 INFO - Directory to install application into. [default: 10:51:41 INFO - "/builds/slave/test"] 10:51:41 INFO - --app=APP Application being installed. [default: firefox] 10:51:41 INFO - mkdir: /builds/slave/test/build/application 10:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:52:15 INFO - Reading from file tmpfile_stdout 10:52:15 INFO - Output received: 10:52:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:52:15 INFO - Running post-action listener: _resource_record_post_action 10:52:15 INFO - [mozharness: 2016-08-12 17:52:15.974451Z] Finished install step (success) 10:52:15 INFO - [mozharness: 2016-08-12 17:52:15.974588Z] Running run-tests step. 10:52:15 INFO - Running pre-action listener: _resource_record_pre_action 10:52:15 INFO - Running main action method: run_tests 10:52:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:52:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:52:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:52:15 INFO - 2016-08-12 10:52:15.989 screenresolution[4914:24125] starting screenresolution argv=screenresolution get 10:52:15 INFO - 2016-08-12 10:52:15.991 screenresolution[4914:24125] Display 0: 1600x1200x32@60 10:52:15 INFO - 2016-08-12 10:52:15.997 screenresolution[4915:24128] starting screenresolution argv=screenresolution list 10:52:16 INFO - Available Modes on Display 0 10:52:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:52:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:52:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:52:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:52:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:52:16 INFO - Intel Iris: 10:52:16 INFO - Chipset Model: Intel Iris 10:52:16 INFO - Type: GPU 10:52:16 INFO - Bus: Built-In 10:52:16 INFO - VRAM (Dynamic, Max): 1536 MB 10:52:16 INFO - Vendor: Intel (0x8086) 10:52:16 INFO - Device ID: 0x0a2e 10:52:16 INFO - Revision ID: 0x0009 10:52:16 INFO - Displays: 10:52:16 INFO - Display: 10:52:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:52:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:52:16 INFO - Display Serial Number: 1600x1200 60 10:52:16 INFO - Main Display: Yes 10:52:16 INFO - Mirror: Off 10:52:16 INFO - Online: Yes 10:52:16 INFO - Rotation: Supported 10:52:16 INFO - Return code: 0 10:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:16 INFO - Python 2.7.3 10:52:16 INFO - Return code: 0 10:52:16 INFO - grabbing minidump binary from tooltool 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:16 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 0x10dc60d30>, '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 0x10d9c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc58b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:52:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:52:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:52:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:16 INFO - Return code: 0 10:52:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:52:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:52:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:16 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/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:52:16 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/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.soUW6aUDzm/Render', 10:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:16 INFO - 'HOME': '/Users/cltbld', 10:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:16 INFO - 'LOGNAME': 'cltbld', 10:52:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:16 INFO - 'MOZ_NO_REMOTE': '1', 10:52:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:16 INFO - 'NO_EM_RESTART': '1', 10:52:16 INFO - 'PAGER': '/bin/cat', 10:52:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:16 INFO - 'PWD': '/builds/slave/test', 10:52:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:16 INFO - 'SHELL': '/bin/bash', 10:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W6qrWB3QYa/Listeners', 10:52:16 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 10:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:16 INFO - 'USER': 'cltbld', 10:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:16 INFO - 'XPC_FLAGS': '0x0', 10:52:16 INFO - 'XPC_SERVICE_NAME': '0', 10:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:16 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/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:52:16 INFO - mozversion application_buildid: 20160812084117 10:52:16 INFO - mozversion application_changeset: a977a28fed2dfed886abd85ab641d83bb3a3a279 10:52:16 INFO - mozversion application_display_name: Nightly 10:52:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:16 INFO - mozversion application_name: Firefox 10:52:16 INFO - mozversion application_remotingname: firefox 10:52:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:52:16 INFO - mozversion application_vendor: Mozilla 10:52:16 INFO - mozversion application_version: 51.0a1 10:52:16 INFO - mozversion platform_buildid: 20160812084117 10:52:16 INFO - mozversion platform_changeset: a977a28fed2dfed886abd85ab641d83bb3a3a279 10:52:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:52:16 INFO - mozversion platform_version: 51.0a1 10:52:16 INFO - using testdate: 1471024336 10:52:16 INFO - actual date: 1471024336 10:52:16 INFO - starting webserver on 'localhost:49354' 10:52:16 INFO - SUITE-START | Running 2 tests 10:52:16 INFO - TEST-START | dromaeo_css 10:52:16 INFO - operating with platform_type : mac_ 10:52:16 INFO - Initialising browser for dromaeo_css test... 10:52:16 INFO - TEST-INFO | started process 4925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpvGm1yD/profile http://localhost:49354/getInfo.html) 10:52:19 INFO - PROCESS | 4925 | __metrics Screen width/height:1600/1200 10:52:19 INFO - PROCESS | 4925 | colorDepth:24 10:52:19 INFO - PROCESS | 4925 | Browser inner width/height: 1024/689 10:52:19 INFO - PROCESS | 4925 | __metrics 10:52:19 ERROR - PROCESS | 4925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 10:52:20 INFO - TEST-INFO | 4925: exit 0 10:52:20 INFO - Browser initialized. 10:52:20 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:20 INFO - TEST-INFO | started process 4929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpvGm1yD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:32 INFO - PROCESS | 4929 | RSS: Main: 254832640 10:52:32 INFO - PROCESS | 4929 | 10:53:21 INFO - PROCESS | 4929 | 1471024401797 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:55:33 INFO - PROCESS | 4929 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49354/tests/dromaeo/cssquery-ext.html) 10:55:35 INFO - PROCESS | 4929 | RSS: Main: 267571200 10:55:35 INFO - PROCESS | 4929 | 10:58:37 INFO - PROCESS | 4929 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-ext.html (next: http://localhost:49354/tests/dromaeo/cssquery-jquery.html) 10:58:38 INFO - PROCESS | 4929 | RSS: Main: 275681280 10:58:38 INFO - PROCESS | 4929 | 11:01:40 INFO - PROCESS | 4929 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49354/tests/dromaeo/cssquery-mootools.html) 11:01:40 INFO - PROCESS | 4929 | RSS: Main: 280465408 11:01:40 INFO - PROCESS | 4929 | 11:04:42 INFO - PROCESS | 4929 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49354/tests/dromaeo/cssquery-prototype.html) 11:04:43 INFO - PROCESS | 4929 | RSS: Main: 279756800 11:04:43 INFO - PROCESS | 4929 | 11:07:46 INFO - PROCESS | 4929 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49354/tests/dromaeo/cssquery-yui.html) 11:07:46 INFO - PROCESS | 4929 | RSS: Main: 284147712 11:07:46 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-yui.html (next: http://localhost:49354/tests/dromaeo/cssquery-dojo.html) 11:10:49 INFO - PROCESS | 4929 | RSS: Main: 286052352 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | __start_tp_report 11:10:49 INFO - PROCESS | 4929 | _x_x_mozilla_page_load 11:10:49 INFO - PROCESS | 4929 | _x_x_mozilla_page_load_details 11:10:49 INFO - PROCESS | 4929 | |i|pagename|runs| 11:10:49 INFO - PROCESS | 4929 | |0;dojo.html;3381.56039714837;3391.542141810855;3416.7949923004635;3427.8971630851074;3431.845566949487;5613.635113717616;5673.773049078037;5680.545556355492;5740.454656807602;5778.162166485857;5657.830265092043;5688.63023903447;5696.25948626679;5728.312602487707;5839.79560715375;5078.542931136206;5178.249153872705;5232.633715639907;5241.161414173733;5263.131583288753;5126.948730512684;5142.6914385137015;5216;5225.686458812484;5313.362396512404;4250.256205164084;5173.844784656466;5198.142306519419;5303.655262407931;5341.305630268079;5169;5189.506996835333;5206.973965130188;5232.555232805216;5256.26412302278;4679.876829560915;4734.928976065362;5051.6716413433005;5147.536721695065;5150.459201783834;5483.479069488392;5573.916391254134;5696.572757043238;5704.629199102086;5764.308283006024;4571.497135315112;5571.916421253644;6176.567640265183;6186.690665466709;6230.501559875199;6143.692815359259;6246.6252024878195;6274.905876411857;6302;6309.968450157766;4709.811607535695;5776.989026920272;5778.942210577925;5821.621594596338;5902.793402230901;6194.008958566697;6240.063990401385;6243.656598887105;6273.153124328157;6290.119383286344;5058.696478211319;5985.16207730918;6195.628262304276;6197.96901015492;6202.906956395657;5039.949600503948;6131.927227014014;6190.164327815687;6195.411435913581;6260.998240281533;6165.84585385369;6180.042093475518;6204.162438070893;6204.410580994799;6244.594101383395;6155.384461553898;6167.321594624587;6240.438360547572;6243;6253.093301471261;4871.196252618278;4951.876203094879;4964.255361695775;4968.552830245295;5039.622028347815;4407.537208593116;4429.180601588652;4437.689361744711;4448;4473.993351495952;5628.099504079328;5710.2576665033275;5734.197212390269;5736.196932429463;5756.280464941882;6125.907024958145;6165.660888651078;6177.938220617826;6234.189555357774;6285.277193122758;5666.320041595035;5678.97778399892;5694.373618901917;5712.257406537124;5741.081426971665;5338.492843179892;5390.541803946709;5390.544552970676;5394.406615272317;5397.892042159135;5376.623636345496;6117.837610854012;6202.162708034358;6216.409441103088;6293.496520278275;6225.750969961151;6235.438810507076;6240.53196010292;6264.874702506016;6299.842503937438;6257.061440783918;6279.654618995999;6282;6285.2457705075685;6285.622862628257;6010.699465026643;6110.892920173631;6114.236541168587;6164.291106522628;6198.783042593487;6227.470664993345;6251.812445626639;6259.937400625936;6265.997440409513;6282.874342513215;6147.07793830911;6170.938290617037;6179.443850053517;6180.443760061616;6181.9690901547;5874.882502349844;6067.514598832171;6105.358937311696;6114;6160.630362178104;4369.475662920343;4489.865304040884;4850.878728031827;5618.494335509824;5985.281766188085;4516.728996260234;4908.533689299511;5629.296337957755;6091.634501929899;6130.325664176848;5851.94148058531;5925.496332811759;5952.136940143569;5962.821115366546;6060.424259695322 11:10:49 INFO - PROCESS | 4929 | |1;ext.html;492.4533767518054;498.7531172069824;536.214445836849;540.5540429145954;544.6106034185557;37348.439773403385;37844.43233351498;39678;39887.401688974685;39988.60011399885;41323.79338103313;41829.79085104578;41916;41939.37090943631;42221.78889105558;9525.618975240983;9710.902890971105;9726;9735.026497350244;9737.707868763948;9538.236941044734;9607.27945404094;9608.519574021306;9634.132928036475;9656.275779316544;9531.618735250582;9607.66373176939;9630.277729170306;9660.806783864318;9674.564644590975;9570.42577445352;9597.856032159523;9636.951815240878;9640.517974101267;9647.421154730739;9519.952400238024;9553.570089345996;9596.376235544738;9631.90368096317;9646.42121472714;32542.86099986489;39536.60463395358;39627.603723962966;39801.80099099486;39831.40252896209;3397.8980630580877;3503.684668379858;3589.820508974567;3591.94612080819;3681.5214022177215;31089.84455077733;31289.390886623758;32175.35649287001;32432.837835810908;32858;3238.676132386766;3272.7381809455187;3279.540864279003;3345.1469875181674;3368.2253081791323;350126;379519;456131;456267;459829.9999999967;57185.85628287494;57509.71245143831;57512;57610.71194644;57686.42313576894;27753.861230693718;31729.206769830478;34649.653503465146;35267.4709879352;36185.457218141746;16112.19439028044;16131.758023629654;16312.184390780414;16367.345306187857;16376.918115409586;11191.2725672831;11912;12404.875951240372;12517.49930002808;12528.498860045678;13499.595012149652;15463;19108.617827643367;19189;19260;7788.4548081634875;7841.4118941078505;7925.365970722329;7978.242067003625;8021.83410479179;706.615173788464;871.7646235516376;1014.5333146752577;1021.0606242256993;1049.4700176411015;29774.55338169929;30113;30119.397612048073;30959.535606965914;31089.844550777554;970.088117169858;1027.306568066552;1073.2433634287963;1086.0931122512632;1111.4553868604326;12868.742625147444;15029.572190641871;15346.923265383602;15611.687766244839;15703.764443533357;577990.110049447;675109;683806;685429;690124;56326.718366407906;56562;57002.714986424806;57165.42834571684;57526.13710794342;1336.5789776220458;1342.1812694256496;1377.2838124175373;1377.9173249605055;1384;29186.7081329184;29929.251768705955;30013.763222879952;30140.84929575338;31198.22004449907;40556;49892.75053624854;49982.25026624531;50013.24980125374;50100.74949625228;482760;575837;576321;576908;577900;25987.870060650333;26109.347266318495;26404.603930941437;27129.72870271351;27852.30369240785;48266;48571;49116.50883491262;49386.506134938194;50093;35375.408106635776;36022;37486.812565937;39533.40699889562;40542.79728601338;36773.26453470862;38366;39009.80495097506;40055.99860003523;40217.59782402139;38151.04622384463;38395.6160438392;38773.41839872348;38803.61196388;40290.99272518211;27074;31158.68841311558;31487.52768708517;35053.47419788654;35063.772767953;25568.872155639103;25691.871540642176;26051.218463446126;26195.607065893644;27116.864415677795 11:10:49 INFO - PROCESS | 4929 | |2;jquery.html;360.7222438722183;375.27384510971257;382.9253295607356;383.9596842331553;402.9697772667049;15984.84015159848;19291.807081929175;20870.89564552179;21574;21831.781682183173;20678.48303792406;20910.477238069056;21197.470063248427;21268.4682882928;21438.785612143874;5770.019096753541;6080.270367555878;6082.178905847721;6090.939090609104;6108.205933228674;5709.685967271798;5931.73307201177;5966.642001479903;5982.521398288149;6051.4856237219665;5779.682117483537;5807;5841.912371314434;5930.673812940287;5947.167396564484;5717.885642287151;5895.852603684899;5902.970485147568;5908.704564771787;5962.4633782959745;5177.715225662587;5179.637425380225;5190.688558686491;5192;5193.948060519384;21426.357209283746;26245.343866403302;26455;26514.86742566275;28225.15324540267;1906.74258975038;2061.701053347256;2082.323244945399;2143.8284937205144;2597.467519158587;8622.65509379624;10490.79018419635;13070.673233169151;14571.417143314255;15219.391224351013;1863.7204419337072;1873.1570793143003;1915.7413749143827;1931.94204173875;1944.4069558784706;128225;133893;134769;136497.3175134128;141141.2942935289;11390.202685811913;11439.656810295704;11658.41707914601;11861.347625880659;11867.465964031639;11842.171048026728;12923.353832308347;13595.796063059062;14424.567262982127;14426.927865360605;7069.540479868792;8430.494170349799;8559.914400855912;8611.095834937367;8641.870371944426;8147.551884646283;8440.535770532557;8446.155384461505;8504.149585041447;8590.527520986405;3487.7035451986358;4543.977280113579;4548.135854187693;4577.519360467103;4622.607078398374;1597.4249270262696;1913.416407995547;1922.1542521290587;1942.4366933589383;1944.3000519812856;849.4096602861076;854.7521218846589;901.7735879204276;937.2408349237004;997.5411310796969;16922.915385422995;20017.699734503993;20310.695339569917;20581.794182057987;20616.69074963877;861.6773253056529;875.4484674654926;878.7275944457111;892.2148509311894;911.539672465414;9528.714138575853;10540.472976351151;10917.39954302521;10922.399268040333;10964.56141754321;448123;552447;597126;609045;630247;130795;138834;141003.2949835265;142106.289468552;144803;959.0649117110761;966.5602151021268;982.9286078174824;984.9261305401981;988.1551273660916;18613.627727445648;18621.44135675932;18795.624087518445;18896.3386281485;18935.71596426027;55639;56354.1546876789;57371.71314143569;58109.83780324455;59175;67415;77999;80272.59863700643;80656.790148149;83038;6975.755848545276;7308.707651693872;7421.443391745533;7561.2060733622175;8186.918130818615;11141.72145696364;11460.656180314603;12946.80579791285;13537.79693304621;13716.588502344946;11095.833562496731;11272.549098036316;11462.770744585228;11766.941165294118;11889;10721.41032243203;10762.838557421488;11149.99650031501;11301.943490282496;11474.94262528682;11531.596394126165;11625.88374116282;11920.701982450508;11986.520539178335;12003.279803211835;7386.926130738624;7438.888416673863;7531.058617672791;7654.73208437702;7660.616969151632;8445.902032735705;10088.940661230465;10820.945895270474;11074.446277686244;11477.713057173303 11:10:49 INFO - PROCESS | 4929 | |3;mootools.html;1517.9392824287033;1567.255553612034;1770.1503278426355;1839.1999480226095;1886.8207520285578;8012.078610959741;8389.203025712563;8634.050254472004;8925.776855578613;8945.194932456086;8670.913290867089;8781.517016564087;8791.560421978907;8800.515971621558;8809.29525637949;2318.791308782205;2361.244401791427;2362.126013375054;2363.669086327907;2368.1948137633203;1887.4337698690406;1958.6670266054805;2363.8936247868887;2368.0054377161546;2372.632242002484;2304.0783686525356;2340.2862127051244;2355.5759963206615;2361.6103342948395;2377.7622237776172;2300.631898896177;2331.7901388875;2336.4158960259933;2342.8711420871846;2349.3656712687566;2339.543788961153;2346.260927807752;2349.7767712067325;2353.51752890657;2363.9645405318934;8934.151255630704;8937.955310223473;8951.955240223757;8984.056674049261;8995.595198216097;4500.212462819027;5303.893922121536;5387.649802762847;5388.865278368033;5402.135658294654;3444.345574340867;3506.281212351462;3509.526213961108;3583.175869550018;3635.2729454109285;890.5057692980394;901.986470202941;1031.9071283584512;1088.2708585247824;1088.515610553304;11120.499577519031;11442.7985061569;11568.363739994296;11590.362530060844;11594.014508766764;4567.634589232854;4575.473820510617;4769.260764581495;4771.976140119277;4776.498467660846;7917.722879699298;10022;10047.04553067472;10047.648332308334;10250;5321.680699158062;5324.227986941872;5359.678419294777;5362.463753624606;5367.302250707383;4396.912061758747;4693.812247510062;4909.705417674951;4909.729964851896;4913.606911447076;3897.9610203897596;3933.4296527003426;4007.1785284016705;4035.9798201008807;4071.75569465833;1078.2506158219962;1271.167385362589;1294.3140135728079;1299.7465494228725;1300.206873806977;827.5655280977535;838.7022606974558;842.2377748137945;912.7170577121113;974.5030034682221;5554.166874968706;5581.6371935824045;5863.2670916135485;5887.587868849225;6020.518358531307;434.86519179054596;442.95348988356403;449.07490569427085;451.3387886745933;452.28087341127764;3450.861965521351;3884.3590807517007;3966.6231707987695;4052.8378864845668;4061.878143655695;10054.64808731691;10493.055624993634;10556.155507559377;10556.788864222672;10727.678169654922;9428.15146636806;10213.693589192337;10539.894601053891;10633.468326583794;10645.988631080036;8043.638036288381;8129.593520323961;8130.959345203236;8178.386621003448;8251.29863961558;4750.382450281441;5224.190250511177;5472.507474327171;5823.708814559171;5884.764609415575;9752.60989560438;9909.603615855285;10008.549615267477;10048.296619236875;10074.093331600192;10043;10111.54498047575;10224.386536807815;10242.53908574131;10253.948730256301;7049.541779784297;7395.149557800922;7531.209223031503;7570.659320330488;7713.845723085395;8513.74458766238;8523.616437260462;8599.183077607617;8616.310695144248;8635.525046122524;7368.6315684214505;7372.926270737438;7520.8871866920945;7574.5076570022775;7594.734184303523;7353.374963128194;7436.330730234305;7502.024736784401;7575.356094732009;7586.924130758622;7031.929680703128;7125.501214914906;7145.714171433085;7147.928520714726;7159.964200179174;4088.7955602220363;5015.84952451427;5061.392632884077;5062.31658726082;5110.207917772751;4938.1358262304675;4952.947496170099;5061.670991385548;5139.922901156411;5184.948150518447 11:10:49 INFO - PROCESS | 4929 | |4;prototype.html;291.26891502329147;304.26216425168957;310.0867943905199;312.1649587353828;313.61268832991254;4674.883127921804;4950.826721064755;5303.23103150043;5641.323041235048;5706.857328566788;5526.58550608704;5543.944560554393;5574.770091963207;5617.354004289508;5621.915671264935;3871.128995975897;3906.921861562767;4222.577742225783;4244.936325955113;4256.723312984662;4123.824709957663;4193.853215137471;4209.789510524477;4251.4898212214575;4283.528811830712;3595.964040359589;4156.480439945007;4165.1669666066755;4169.749815011094;4231.196072746168;4202.235061274288;4204.957950420488;4209.326507758744;4223.043869291478;4237.279662457389;2866.899658511942;2971.747401470856;3649.908752281188;3661.7619854709624;3681.0981309579324;4761.59526440253;4929.2359684248995;5160.690358578459;5389.272448219519;5472.5621950243885;4269.402283680287;4636.629069674418;4796.56830885222;4800.375951126366;4803.927941080887;4765.832371069076;5445.008660053516;5842.9908597072545;5860.120981852756;5866.618669786493;3313.353895990283;3407.6710083067624;3891.2217556488818;4016.3172260715746;4024.3158663027357;5364.302640656729;6185.288691800411;6193.6903154842075;6219.751209951596;6230.719617617218;3549.4853246279145;4061.634452899253;4078.286299897506;4079.9592004080173;4094.529129150126;3689.5941446441407;3745.7752534847996;3857.4599556062176;3985.70107241958;4156.173801814734;4650.139724150975;4695.24876019842;4723.929141062887;4745.335653008581;4767.95232047682;4833.734144622009;5054.82308119214;5900.970495147497;5969.134475501115;5987.371326010793;1296.241698606307;1329.3286890120621;1336.6524703576945;1355.3223388305846;1361.685973036025;778.9766307010799;781.9022622172229;891.9018907920124;903.8508646073456;917.1791246834047;4743.537217831003;4755.00289878252;4756.524347565285;5362.70505122222;5473.534749546254;5103.566196873233;5734.964087748873;6000.309964354068;6024.3072046714315;6053.182820319289;4611.054733779567;4900.142475066849;4992.2761199626575;5263.499967503081;5439.456054394529;2331.4870728439714;2387.9641805372935;2500.2124330835727;2623.622598135994;2712.972870271272;4909.582685471775;5075.390953085654;5266.631335806457;5270.183121616155;5367.597430192673;4832.49258827818;4858.78135483904;4941.332920055746;5201.739913004335;5262.815801447007;4402.71382360152;4670.859874203779;4831.396075490564;5039.462963796004;5274.419813820554;5012.4736902626155;5070.4929507049;5144.845654630367;5154.61340399464;5157.690538567548;4105.794710264415;4202.810873510638;5001.399832020181;5096.623911543788;5933.821985340447;6119.357467465852;6186.381361863778;6284.585968157128;6289.245290564979;6309.652969086561;3364.5626068610923;3962.782046987328;3993.540742814497;4001.779902105412;4013.7190396671954;5704.771809127755;5778.335491418541;5986.970065149646;6072.483838873569;6073.514118870391;5757.568182386254;5936.940630593639;5972.462478376967;5980.9401905980385;5993.370696077023;5972.8805423892145;5977.581569290108;5992.2809262886985;6007.197840647701;6014.646704491454;4624.491305956275;4719.2921061841;5770.278715160605;5791.681457519709;5857.560682948711;5172.844814655567;5819.592628515963;5960.314563825043;5963.2844058713235;5973.372795856372;5338.505218538815;5470.23753004746;5511.944880551143;5835.4748072673665;5837.29952405714 11:10:49 INFO - PROCESS | 4929 | |5;yui.html;613.444832426654;699.4439420660574;699.9465803965032;773.5010917957917;823.7355659063337;12033.939830300847;12829.807552886703;16119.113448760314;16156.03063816172;17114.572135696613;13491.325433728323;16467.094309812954;16594.253258603363;16669.33322667092;16682.082485463325;831.5509624802614;854.6495936665937;857.4340934982913;857.5283594023293;858.9312854971619;684.907537482441;773.2499475508747;839.08539691736;857.0101532729676;872.1670804381832;876.7676565710092;885.8626912828489;891.9777005574848;916.102219824569;916.1662886773038;890.8307421589909;909.5088652127843;910.3627460777416;910.517425764346;910.9544522773868;627.3130921640796;658.3646780856449;666.1140682891743;676.5940435738567;677.7864972533636;15500.22498875063;15662.138582377964;15781.368745250176;15807.130607816565;15888.523344299689;14497.202653854034;14518.201498917555;14528.636784080376;14538.200398978051;14657.560273191715;11962.897421112362;12139.028877689763;12139.757204855854;12196;12341.75316493665;3865.942010869839;3900.7854567998747;3903.238868420659;3911.9804400977814;4047.150098479323;123858.38070809678;124795;126178;126558.36720816429;126730;8727.301815854717;11118.722031949266;11121.110311175087;11142.610008649659;11224.66326010221;22817.88591057034;22980.770192297863;23012.76987230106;23070.7692923072;23076;7616.771496855104;8134.75595732129;8136.186381361935;8364.749057528285;8415.200555947175;4489.461264648197;4559.566841150152;4560.17916774977;4597.42532183477;4674.485806561275;3652.397354436488;3721.199942012426;3766.3597188478025;3769.754965927206;3773.8490460381277;653.1182903080897;662.9834254143685;663.4228221447372;667.9098321726602;675.2100042949761;593.1132956230377;595.9910601340983;612.4334990134108;665.4609766089483;703.6341102626606;7574.924250757422;8807.854978852709;9178.758414360509;9438.764030899145;9666.984966578408;656.1699450195506;672.2840175213382;678.5369110130196;681.6489507903434;688.6625553478859;4376.978115109468;4636.79443344726;4670.579647831643;4689.718616882929;4707.105649926503;120685;152788;166877.16561417116;170330;172780;103510;122638.5472290567;132062;132369;148263;116256;117514;119032;125448.99999999818;125485.74514254923;7233.638318083969;8185;8911.844089862583;9025;9060.95798983099;47027.82430439266;61124.694376527834;67800.66099669668;69835.30164698491;69837.65081174561;78955;93637;103468.48265758622;108157;110446.95530446891;11806.82289765637;12014.63956081319;13148.737025259632;13311.600651980456;13391.598252052454;14886.253929747001;15305.387784488496;15389;15524.534263972098;15871.444499442465;14175.787363189767;14481.131132132106;14633.634159146106;14644.780328295297;14903.180325082225;14088.943329250142;14283.500077497238;14339.498117565836;14341.139531628136;14824.332905019515;13585.646257147997;13642.386092625657;13647.590572282847;13858.861411385757;14284.642883927985;11420.428978550874;11443.485043173243;11560.479778409823;11622.360770157722;11870.228435151688;8311;9641.907384205508;10084.848727269244;10468.68593942183;11414.258073225214 11:10:49 INFO - PROCESS | 4929 | __end_tp_report 11:10:49 INFO - PROCESS | 4929 | __start_cc_report 11:10:49 INFO - PROCESS | 4929 | _x_x_mozilla_cycle_collect,416 11:10:49 INFO - PROCESS | 4929 | __end_cc_report 11:10:49 INFO - PROCESS | 4929 | __startTimestamp1471025449335__endTimestamp 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | ------- Summary: start ------- 11:10:49 INFO - PROCESS | 4929 | Number of tests: 6 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | [#0] dojo.html Cycles:165 Average:5645.23 Median:5778.16 stddev:675.07 (11.7%) stddev-sans-first:653.37 11:10:49 INFO - PROCESS | 4929 | Values: 3381.6 3391.5 3416.8 3427.9 3431.8 5613.6 5673.8 5680.5 5740.5 5778.2 5657.8 5688.6 5696.3 5728.3 5839.8 5078.5 5178.2 5232.6 5241.2 5263.1 5126.9 5142.7 5216.0 5225.7 5313.4 4250.3 5173.8 5198.1 5303.7 5341.3 5169.0 5189.5 5207.0 5232.6 5256.3 4679.9 4734.9 5051.7 5147.5 5150.5 5483.5 5573.9 5696.6 5704.6 5764.3 4571.5 5571.9 6176.6 6186.7 6230.5 6143.7 6246.6 6274.9 6302.0 6310.0 4709.8 5777.0 5778.9 5821.6 5902.8 6194.0 6240.1 6243.7 6273.2 6290.1 5058.7 5985.2 6195.6 6198.0 6202.9 5039.9 6131.9 6190.2 6195.4 6261.0 6165.8 6180.0 6204.2 6204.4 6244.6 6155.4 6167.3 6240.4 6243.0 6253.1 4871.2 4951.9 4964.3 4968.6 5039.6 4407.5 4429.2 4437.7 4448.0 4474.0 5628.1 5710.3 5734.2 5736.2 5756.3 6125.9 6165.7 6177.9 6234.2 6285.3 5666.3 5679.0 5694.4 5712.3 5741.1 5338.5 5390.5 5390.5 5394.4 5397.9 5376.6 6117.8 6202.2 6216.4 6293.5 6225.8 6235.4 6240.5 6264.9 6299.8 6257.1 6279.7 6282.0 6285.2 6285.6 6010.7 6110.9 6114.2 6164.3 6198.8 6227.5 6251.8 6259.9 6266.0 6282.9 6147.1 6170.9 6179.4 6180.4 6182.0 5874.9 6067.5 6105.4 6114.0 6160.6 4369.5 4489.9 4850.9 5618.5 5985.3 4516.7 4908.5 5629.3 6091.6 6130.3 5851.9 5925.5 5952.1 5962.8 6060.4 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | [#1] ext.html Cycles:180 Average:67354.94 Median:38906.71 stddev:149236.88 (383.6%) stddev-sans-first:149571.10 11:10:49 INFO - PROCESS | 4929 | Values: 492.5 498.8 536.2 540.6 544.6 37348.4 37844.4 39678.0 39887.4 39988.6 41323.8 41829.8 41916.0 41939.4 42221.8 9525.6 9710.9 9726.0 9735.0 9737.7 9538.2 9607.3 9608.5 9634.1 9656.3 9531.6 9607.7 9630.3 9660.8 9674.6 9570.4 9597.9 9637.0 9640.5 9647.4 9520.0 9553.6 9596.4 9631.9 9646.4 32542.9 39536.6 39627.6 39801.8 39831.4 3397.9 3503.7 3589.8 3591.9 3681.5 31089.8 31289.4 32175.4 32432.8 32858.0 3238.7 3272.7 3279.5 3345.1 3368.2 350126.0 379519.0 456131.0 456267.0 459830.0 57185.9 57509.7 57512.0 57610.7 57686.4 27753.9 31729.2 34649.7 35267.5 36185.5 16112.2 16131.8 16312.2 16367.3 16376.9 11191.3 11912.0 12404.9 12517.5 12528.5 13499.6 15463.0 19108.6 19189.0 19260.0 7788.5 7841.4 7925.4 7978.2 8021.8 706.6 871.8 1014.5 1021.1 1049.5 29774.6 30113.0 30119.4 30959.5 31089.8 970.1 1027.3 1073.2 1086.1 1111.5 12868.7 15029.6 15346.9 15611.7 15703.8 577990.1 675109.0 683806.0 685429.0 690124.0 56326.7 56562.0 57002.7 57165.4 57526.1 1336.6 1342.2 1377.3 1377.9 1384.0 29186.7 29929.3 30013.8 30140.8 31198.2 40556.0 49892.8 49982.3 50013.2 50100.7 482760.0 575837.0 576321.0 576908.0 577900.0 25987.9 26109.3 26404.6 27129.7 27852.3 48266.0 48571.0 49116.5 49386.5 50093.0 35375.4 36022.0 37486.8 39533.4 40542.8 36773.3 38366.0 39009.8 40056.0 40217.6 38151.0 38395.6 38773.4 38803.6 40291.0 27074.0 31158.7 31487.5 35053.5 35063.8 25568.9 25691.9 26051.2 26195.6 27116.9 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | [#2] jquery.html Cycles:180 Average:35046.71 Median:27370.01 stddev:96441.48 (352.4%) stddev-sans-first:96676.86 11:10:49 INFO - PROCESS | 4929 | Values: 360.7 375.3 382.9 384.0 403.0 15984.8 19291.8 20870.9 21574.0 21831.8 20678.5 20910.5 21197.5 21268.5 21438.8 5770.0 6080.3 6082.2 6090.9 6108.2 5709.7 5931.7 5966.6 5982.5 6051.5 5779.7 5807.0 5841.9 5930.7 5947.2 5717.9 5895.9 5903.0 5908.7 5962.5 5177.7 5179.6 5190.7 5192.0 5193.9 21426.4 26245.3 26455.0 26514.9 28225.2 1906.7 2061.7 2082.3 2143.8 2597.5 8622.7 10490.8 13070.7 14571.4 15219.4 1863.7 1873.2 1915.7 1931.9 1944.4 128225.0 133893.0 134769.0 136497.3 141141.3 11390.2 11439.7 11658.4 11861.3 11867.5 11842.2 12923.4 13595.8 14424.6 14426.9 7069.5 8430.5 8559.9 8611.1 8641.9 8147.6 8440.5 8446.2 8504.1 8590.5 3487.7 4544.0 4548.1 4577.5 4622.6 1597.4 1913.4 1922.2 1942.4 1944.3 849.4 854.8 901.8 937.2 997.5 16922.9 20017.7 20310.7 20581.8 20616.7 861.7 875.4 878.7 892.2 911.5 9528.7 10540.5 10917.4 10922.4 10964.6 448123.0 552447.0 597126.0 609045.0 630247.0 130795.0 138834.0 141003.3 142106.3 144803.0 959.1 966.6 982.9 984.9 988.2 18613.6 18621.4 18795.6 18896.3 18935.7 55639.0 56354.2 57371.7 58109.8 59175.0 67415.0 77999.0 80272.6 80656.8 83038.0 6975.8 7308.7 7421.4 7561.2 8186.9 11141.7 11460.7 12946.8 13537.8 13716.6 11095.8 11272.5 11462.8 11766.9 11889.0 10721.4 10762.8 11150.0 11301.9 11474.9 11531.6 11625.9 11920.7 11986.5 12003.3 7386.9 7438.9 7531.1 7654.7 7660.6 8445.9 10088.9 10820.9 11074.4 11477.7 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | [#3] mootools.html Cycles:180 Average:5667.31 Median:4759.82 stddev:3203.06 (67.3%) stddev-sans-first:3196.87 11:10:49 INFO - PROCESS | 4929 | Values: 1517.9 1567.3 1770.2 1839.2 1886.8 8012.1 8389.2 8634.1 8925.8 8945.2 8670.9 8781.5 8791.6 8800.5 8809.3 2318.8 2361.2 2362.1 2363.7 2368.2 1887.4 1958.7 2363.9 2368.0 2372.6 2304.1 2340.3 2355.6 2361.6 2377.8 2300.6 2331.8 2336.4 2342.9 2349.4 2339.5 2346.3 2349.8 2353.5 2364.0 8934.2 8938.0 8952.0 8984.1 8995.6 4500.2 5303.9 5387.6 5388.9 5402.1 3444.3 3506.3 3509.5 3583.2 3635.3 890.5 902.0 1031.9 1088.3 1088.5 11120.5 11442.8 11568.4 11590.4 11594.0 4567.6 4575.5 4769.3 4772.0 4776.5 7917.7 10022.0 10047.0 10047.6 10250.0 5321.7 5324.2 5359.7 5362.5 5367.3 4396.9 4693.8 4909.7 4909.7 4913.6 3898.0 3933.4 4007.2 4036.0 4071.8 1078.3 1271.2 1294.3 1299.7 1300.2 827.6 838.7 842.2 912.7 974.5 5554.2 5581.6 5863.3 5887.6 6020.5 434.9 443.0 449.1 451.3 452.3 3450.9 3884.4 3966.6 4052.8 4061.9 10054.6 10493.1 10556.2 10556.8 10727.7 9428.2 10213.7 10539.9 10633.5 10646.0 8043.6 8129.6 8131.0 8178.4 8251.3 4750.4 5224.2 5472.5 5823.7 5884.8 9752.6 9909.6 10008.5 10048.3 10074.1 10043.0 10111.5 10224.4 10242.5 10253.9 7049.5 7395.1 7531.2 7570.7 7713.8 8513.7 8523.6 8599.2 8616.3 8635.5 7368.6 7372.9 7520.9 7574.5 7594.7 7353.4 7436.3 7502.0 7575.4 7586.9 7031.9 7125.5 7145.7 7147.9 7160.0 4088.8 5015.8 5061.4 5062.3 5110.2 4938.1 4952.9 5061.7 5139.9 5184.9 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | [#4] prototype.html Cycles:180 Average:4572.01 Median:4946.08 stddev:1438.13 (29.1%) stddev-sans-first:1405.81 11:10:49 INFO - PROCESS | 4929 | Values: 291.3 304.3 310.1 312.2 313.6 4674.9 4950.8 5303.2 5641.3 5706.9 5526.6 5543.9 5574.8 5617.4 5621.9 3871.1 3906.9 4222.6 4244.9 4256.7 4123.8 4193.9 4209.8 4251.5 4283.5 3596.0 4156.5 4165.2 4169.7 4231.2 4202.2 4205.0 4209.3 4223.0 4237.3 2866.9 2971.7 3649.9 3661.8 3681.1 4761.6 4929.2 5160.7 5389.3 5472.6 4269.4 4636.6 4796.6 4800.4 4803.9 4765.8 5445.0 5843.0 5860.1 5866.6 3313.4 3407.7 3891.2 4016.3 4024.3 5364.3 6185.3 6193.7 6219.8 6230.7 3549.5 4061.6 4078.3 4080.0 4094.5 3689.6 3745.8 3857.5 3985.7 4156.2 4650.1 4695.2 4723.9 4745.3 4768.0 4833.7 5054.8 5901.0 5969.1 5987.4 1296.2 1329.3 1336.7 1355.3 1361.7 779.0 781.9 891.9 903.9 917.2 4743.5 4755.0 4756.5 5362.7 5473.5 5103.6 5735.0 6000.3 6024.3 6053.2 4611.1 4900.1 4992.3 5263.5 5439.5 2331.5 2388.0 2500.2 2623.6 2713.0 4909.6 5075.4 5266.6 5270.2 5367.6 4832.5 4858.8 4941.3 5201.7 5262.8 4402.7 4670.9 4831.4 5039.5 5274.4 5012.5 5070.5 5144.8 5154.6 5157.7 4105.8 4202.8 5001.4 5096.6 5933.8 6119.4 6186.4 6284.6 6289.2 6309.7 3364.6 3962.8 3993.5 4001.8 4013.7 5704.8 5778.3 5987.0 6072.5 6073.5 5757.6 5936.9 5972.5 5980.9 5993.4 5972.9 5977.6 5992.3 6007.2 6014.6 4624.5 4719.3 5770.3 5791.7 5857.6 5172.8 5819.6 5960.3 5963.3 5973.4 5338.5 5470.2 5511.9 5835.5 5837.3 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - PROCESS | 4929 | [#5] yui.html Cycles:180 Average:26152.22 Median:3686.80 stddev:42437.30 (1151.1%) stddev-sans-first:42513.02 11:10:49 INFO - PROCESS | 4929 | Values: 613.4 699.4 699.9 773.5 823.7 12033.9 12829.8 16119.1 16156.0 17114.6 13491.3 16467.1 16594.3 16669.3 16682.1 831.6 854.6 857.4 857.5 858.9 684.9 773.2 839.1 857.0 872.2 876.8 885.9 892.0 916.1 916.2 890.8 909.5 910.4 910.5 911.0 627.3 658.4 666.1 676.6 677.8 15500.2 15662.1 15781.4 15807.1 15888.5 14497.2 14518.2 14528.6 14538.2 14657.6 11962.9 12139.0 12139.8 12196.0 12341.8 3865.9 3900.8 3903.2 3912.0 4047.2 123858.4 124795.0 126178.0 126558.4 126730.0 8727.3 11118.7 11121.1 11142.6 11224.7 22817.9 22980.8 23012.8 23070.8 23076.0 7616.8 8134.8 8136.2 8364.7 8415.2 4489.5 4559.6 4560.2 4597.4 4674.5 3652.4 3721.2 3766.4 3769.8 3773.8 653.1 663.0 663.4 667.9 675.2 593.1 596.0 612.4 665.5 703.6 7574.9 8807.9 9178.8 9438.8 9667.0 656.2 672.3 678.5 681.6 688.7 4377.0 4636.8 4670.6 4689.7 4707.1 120685.0 152788.0 166877.2 170330.0 172780.0 103510.0 122638.5 132062.0 132369.0 148263.0 116256.0 117514.0 119032.0 125449.0 125485.7 7233.6 8185.0 8911.8 9025.0 9061.0 47027.8 61124.7 67800.7 69835.3 69837.7 78955.0 93637.0 103468.5 108157.0 110447.0 11806.8 12014.6 13148.7 13311.6 13391.6 14886.3 15305.4 15389.0 15524.5 15871.4 14175.8 14481.1 14633.6 14644.8 14903.2 14088.9 14283.5 14339.5 14341.1 14824.3 13585.6 13642.4 13647.6 13858.9 14284.6 11420.4 11443.5 11560.5 11622.4 11870.2 8311.0 9641.9 10084.8 10468.7 11414.3 11:10:49 INFO - PROCESS | 4929 | -------- Summary: end -------- 11:10:49 INFO - PROCESS | 4929 | 11:10:49 INFO - TEST-INFO | 4929: exit 0 11:10:49 INFO - TEST-OK | dromaeo_css | took 1113399ms 11:10:49 INFO - TEST-START | kraken 11:10:49 INFO - operating with platform_type : mac_ 11:10:49 INFO - Initialising browser for kraken test... 11:10:50 INFO - TEST-INFO | started process 4937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpNrL0Ab/profile http://localhost:49354/getInfo.html) 11:10:52 INFO - PROCESS | 4937 | __metrics Screen width/height:1600/1200 11:10:52 INFO - PROCESS | 4937 | colorDepth:24 11:10:52 INFO - PROCESS | 4937 | Browser inner width/height: 1024/689 11:10:52 INFO - PROCESS | 4937 | __metrics 11:10:52 ERROR - PROCESS | 4937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:10:53 INFO - TEST-INFO | 4937: exit 0 11:10:53 INFO - Browser initialized. 11:10:53 INFO - Running cycle 1/1 for kraken test... 11:10:53 INFO - TEST-INFO | started process 4939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpNrL0Ab/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:06 INFO - PROCESS | 4939 | RSS: Main: 254529536 11:11:06 INFO - PROCESS | 4939 | 11:11:08 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:09 INFO - PROCESS | 4939 | RSS: Main: 267460608 11:11:09 INFO - PROCESS | 4939 | 11:11:12 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-dft) 11:11:12 INFO - PROCESS | 4939 | RSS: Main: 276131840 11:11:12 INFO - PROCESS | 4939 | 11:11:16 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-fft) 11:11:16 INFO - PROCESS | 4939 | RSS: Main: 278974464 11:11:16 INFO - PROCESS | 4939 | 11:11:18 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-oscillator) 11:11:19 INFO - PROCESS | 4939 | RSS: Main: 280358912 11:11:19 INFO - PROCESS | 4939 | 11:11:21 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:22 INFO - PROCESS | 4939 | RSS: Main: 280674304 11:11:22 INFO - PROCESS | 4939 | 11:11:25 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49354/tests/kraken/driver.html?testName=imaging-darkroom) 11:11:25 INFO - PROCESS | 4939 | RSS: Main: 280829952 11:11:25 INFO - PROCESS | 4939 | 11:11:29 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49354/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:29 INFO - PROCESS | 4939 | RSS: Main: 281690112 11:11:29 INFO - PROCESS | 4939 | 11:11:33 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49354/tests/kraken/driver.html?testName=json-parse-financial) 11:11:33 INFO - PROCESS | 4939 | RSS: Main: 282640384 11:11:33 INFO - PROCESS | 4939 | 11:11:35 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:35 INFO - PROCESS | 4939 | RSS: Main: 282062848 11:11:35 INFO - PROCESS | 4939 | 11:11:37 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:38 INFO - PROCESS | 4939 | RSS: Main: 282234880 11:11:38 INFO - PROCESS | 4939 | 11:11:40 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:41 INFO - PROCESS | 4939 | RSS: Main: 282615808 11:11:41 INFO - PROCESS | 4939 | 11:11:44 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:45 INFO - PROCESS | 4939 | RSS: Main: 282759168 11:11:45 INFO - PROCESS | 4939 | 11:11:47 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:48 INFO - PROCESS | 4939 | RSS: Main: 282640384 11:11:48 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49354/tests/kraken/driver.html?testName=ai-astar) 11:11:50 INFO - PROCESS | 4939 | RSS: Main: 283504640 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | __start_tp_report 11:11:50 INFO - PROCESS | 4939 | _x_x_mozilla_page_load 11:11:50 INFO - PROCESS | 4939 | _x_x_mozilla_page_load_details 11:11:50 INFO - PROCESS | 4939 | |i|pagename|runs| 11:11:50 INFO - PROCESS | 4939 | |0;ai-astar;106;120;108;118;118;118;113;118;118;119 11:11:50 INFO - PROCESS | 4939 | |1;audio-beat-detection;144;111;134;195;143;125;161;144;198;108 11:11:50 INFO - PROCESS | 4939 | |2;audio-dft;197;196;213;216;196;197;195;202;197;189 11:11:50 INFO - PROCESS | 4939 | |3;audio-fft;78;82;76;142;59;57;60;62;143;60 11:11:50 INFO - PROCESS | 4939 | |4;audio-oscillator;71;96;154;76;72;79;118;87;104;143 11:11:50 INFO - PROCESS | 4939 | |5;imaging-gaussian-blur;93;89;93;90;129;88;105;115;92;89 11:11:50 INFO - PROCESS | 4939 | |6;imaging-darkroom;153;97;111;146;109;104;111;110;107;130 11:11:50 INFO - PROCESS | 4939 | |7;imaging-desaturate;126;145;110;129;146;151;96;123;160;87 11:11:50 INFO - PROCESS | 4939 | |8;json-parse-financial;55;59;57;57;58;58;58;55;58;57 11:11:50 INFO - PROCESS | 4939 | |9;json-stringify-tinderbox;71;71;80;77;83;81;78;64;73;75 11:11:50 INFO - PROCESS | 4939 | |10;stanford-crypto-aes;89;90;88;88;85;86;83;87;85;90 11:11:50 INFO - PROCESS | 4939 | |11;stanford-crypto-ccm;155;162;147;177;163;161;134;142;158;170 11:11:50 INFO - PROCESS | 4939 | |12;stanford-crypto-pbkdf2;172;171;170;171;173;168;169;175;168;168 11:11:50 INFO - PROCESS | 4939 | |13;stanford-crypto-sha256-iterative;69;72;70;67;67;67;69;69;70;77 11:11:50 INFO - PROCESS | 4939 | __end_tp_report 11:11:50 INFO - PROCESS | 4939 | __start_cc_report 11:11:50 INFO - PROCESS | 4939 | _x_x_mozilla_cycle_collect,1049 11:11:50 INFO - PROCESS | 4939 | __end_cc_report 11:11:50 INFO - PROCESS | 4939 | __startTimestamp1471025510427__endTimestamp 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | ------- Summary: start ------- 11:11:50 INFO - PROCESS | 4939 | Number of tests: 14 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#0] ai-astar Cycles:10 Average:115.60 Median:118.00 stddev:4.90 (4.2%) stddev-sans-first:3.77 11:11:50 INFO - PROCESS | 4939 | Values: 106.0 120.0 108.0 118.0 118.0 118.0 113.0 118.0 118.0 119.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:144.00 stddev:30.91 (21.5%) stddev-sans-first:32.78 11:11:50 INFO - PROCESS | 4939 | Values: 144.0 111.0 134.0 195.0 143.0 125.0 161.0 144.0 198.0 108.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#2] audio-dft Cycles:10 Average:199.80 Median:197.00 stddev:8.39 (4.3%) stddev-sans-first:8.84 11:11:50 INFO - PROCESS | 4939 | Values: 197.0 196.0 213.0 216.0 196.0 197.0 195.0 202.0 197.0 189.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#3] audio-fft Cycles:10 Average:81.90 Median:61.00 stddev:33.16 (54.4%) stddev-sans-first:35.14 11:11:50 INFO - PROCESS | 4939 | Values: 78.0 82.0 76.0 142.0 59.0 57.0 60.0 62.0 143.0 60.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:74.00 stddev:29.69 (40.1%) stddev-sans-first:29.58 11:11:50 INFO - PROCESS | 4939 | Values: 71.0 96.0 154.0 76.0 72.0 79.0 118.0 87.0 104.0 143.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:89.50 stddev:13.78 (15.4%) stddev-sans-first:14.49 11:11:50 INFO - PROCESS | 4939 | Values: 93.0 89.0 93.0 90.0 129.0 88.0 105.0 115.0 92.0 89.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#6] imaging-darkroom Cycles:10 Average:117.80 Median:120.50 stddev:18.72 (15.5%) stddev-sans-first:14.90 11:11:50 INFO - PROCESS | 4939 | Values: 153.0 97.0 111.0 146.0 109.0 104.0 111.0 110.0 107.0 130.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#7] imaging-desaturate Cycles:10 Average:127.30 Median:148.50 stddev:24.08 (16.2%) stddev-sans-first:25.54 11:11:50 INFO - PROCESS | 4939 | Values: 126.0 145.0 110.0 129.0 146.0 151.0 96.0 123.0 160.0 87.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.32 (2.3%) stddev-sans-first:1.13 11:11:50 INFO - PROCESS | 4939 | Values: 55.0 59.0 57.0 57.0 58.0 58.0 58.0 55.0 58.0 57.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#9] json-stringify-tinderbox Cycles:10 Average:75.30 Median:77.50 stddev:5.72 (7.4%) stddev-sans-first:5.85 11:11:50 INFO - PROCESS | 4939 | Values: 71.0 71.0 80.0 77.0 83.0 81.0 78.0 64.0 73.0 75.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:88.00 stddev:2.33 (2.6%) stddev-sans-first:2.37 11:11:50 INFO - PROCESS | 4939 | Values: 89.0 90.0 88.0 88.0 85.0 86.0 83.0 87.0 85.0 90.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#11] stanford-crypto-ccm Cycles:10 Average:156.90 Median:161.50 stddev:12.93 (8.0%) stddev-sans-first:13.70 11:11:50 INFO - PROCESS | 4939 | Values: 155.0 162.0 147.0 177.0 163.0 161.0 134.0 142.0 158.0 170.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.00 stddev:2.37 (1.4%) stddev-sans-first:2.45 11:11:50 INFO - PROCESS | 4939 | Values: 172.0 171.0 170.0 171.0 173.0 168.0 169.0 175.0 168.0 168.0 11:11:50 INFO - PROCESS | 4939 | 11:11:50 INFO - PROCESS | 4939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:3.02 (4.3%) stddev-sans-first:3.19 11:11:50 INFO - PROCESS | 4939 | Values: 69.0 72.0 70.0 67.0 67.0 67.0 69.0 69.0 70.0 77.0 11:11:50 INFO - PROCESS | 4939 | -------- Summary: end -------- 11:11:50 INFO - PROCESS | 4939 | 11:11:51 INFO - TEST-INFO | 4939: exit 0 11:11:51 INFO - TEST-OK | kraken | took 61268ms 11:11:51 INFO - SUITE-END | took 1174s 11:11:51 INFO - Completed test suite (00:19:34) 11:11:51 INFO - javascript benchmark 11:11:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7310.172076826198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.56039714837, 3391.542141810855, 3416.7949923004635, 3427.8971630851074, 3431.845566949487, 5613.635113717616, 5673.773049078037, 5680.545556355492, 5740.454656807602, 5778.162166485857, 5657.830265092043, 5688.63023903447, 5696.25948626679, 5728.312602487707, 5839.79560715375, 5078.542931136206, 5178.249153872705, 5232.633715639907, 5241.161414173733, 5263.131583288753, 5126.948730512684, 5142.6914385137015, 5216.0, 5225.686458812484, 5313.362396512404, 4250.256205164084, 5173.844784656466, 5198.142306519419, 5303.655262407931, 5341.305630268079, 5169.0, 5189.506996835333, 5206.973965130188, 5232.555232805216, 5256.26412302278, 4679.876829560915, 4734.928976065362, 5051.6716413433005, 5147.536721695065, 5150.459201783834, 5483.479069488392, 5573.916391254134, 5696.572757043238, 5704.629199102086, 5764.308283006024, 4571.497135315112, 5571.916421253644, 6176.567640265183, 6186.690665466709, 6230.501559875199, 6143.692815359259, 6246.6252024878195, 6274.905876411857, 6302.0, 6309.968450157766, 4709.811607535695, 5776.989026920272, 5778.942210577925, 5821.621594596338, 5902.793402230901, 6194.008958566697, 6240.063990401385, 6243.656598887105, 6273.153124328157, 6290.119383286344, 5058.696478211319, 5985.16207730918, 6195.628262304276, 6197.96901015492, 6202.906956395657, 5039.949600503948, 6131.927227014014, 6190.164327815687, 6195.411435913581, 6260.998240281533, 6165.84585385369, 6180.042093475518, 6204.162438070893, 6204.410580994799, 6244.594101383395, 6155.384461553898, 6167.321594624587, 6240.438360547572, 6243.0, 6253.093301471261, 4871.196252618278, 4951.876203094879, 4964.255361695775, 4968.552830245295, 5039.622028347815, 4407.537208593116, 4429.180601588652, 4437.689361744711, 4448.0, 4473.993351495952, 5628.099504079328, 5710.2576665033275, 5734.197212390269, 5736.196932429463, 5756.280464941882, 6125.907024958145, 6165.660888651078, 6177.938220617826, 6234.189555357774, 6285.277193122758, 5666.320041595035, 5678.97778399892, 5694.373618901917, 5712.257406537124, 5741.081426971665, 5338.492843179892, 5390.541803946709, 5390.544552970676, 5394.406615272317, 5397.892042159135, 5376.623636345496, 6117.837610854012, 6202.162708034358, 6216.409441103088, 6293.496520278275, 6225.750969961151, 6235.438810507076, 6240.53196010292, 6264.874702506016, 6299.842503937438, 6257.061440783918, 6279.654618995999, 6282.0, 6285.2457705075685, 6285.622862628257, 6010.699465026643, 6110.892920173631, 6114.236541168587, 6164.291106522628, 6198.783042593487, 6227.470664993345, 6251.812445626639, 6259.937400625936, 6265.997440409513, 6282.874342513215, 6147.07793830911, 6170.938290617037, 6179.443850053517, 6180.443760061616, 6181.9690901547, 5874.882502349844, 6067.514598832171, 6105.358937311696, 6114.0, 6160.630362178104, 4369.475662920343, 4489.865304040884, 4850.878728031827, 5618.494335509824, 5985.281766188085, 4516.728996260234, 4908.533689299511, 5629.296337957755, 6091.634501929899, 6130.325664176848, 5851.94148058531, 5925.496332811759, 5952.136940143569, 5962.821115366546, 6060.424259695322], "value": 5605.624952663261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.4533767518054, 498.7531172069824, 536.214445836849, 540.5540429145954, 544.6106034185557, 37348.439773403385, 37844.43233351498, 39678.0, 39887.401688974685, 39988.60011399885, 41323.79338103313, 41829.79085104578, 41916.0, 41939.37090943631, 42221.78889105558, 9525.618975240983, 9710.902890971105, 9726.0, 9735.026497350244, 9737.707868763948, 9538.236941044734, 9607.27945404094, 9608.519574021306, 9634.132928036475, 9656.275779316544, 9531.618735250582, 9607.66373176939, 9630.277729170306, 9660.806783864318, 9674.564644590975, 9570.42577445352, 9597.856032159523, 9636.951815240878, 9640.517974101267, 9647.421154730739, 9519.952400238024, 9553.570089345996, 9596.376235544738, 9631.90368096317, 9646.42121472714, 32542.86099986489, 39536.60463395358, 39627.603723962966, 39801.80099099486, 39831.40252896209, 3397.8980630580877, 3503.684668379858, 3589.820508974567, 3591.94612080819, 3681.5214022177215, 31089.84455077733, 31289.390886623758, 32175.35649287001, 32432.837835810908, 32858.0, 3238.676132386766, 3272.7381809455187, 3279.540864279003, 3345.1469875181674, 3368.2253081791323, 350126.0, 379519.0, 456131.0, 456267.0, 459829.9999999967, 57185.85628287494, 57509.71245143831, 57512.0, 57610.71194644, 57686.42313576894, 27753.861230693718, 31729.206769830478, 34649.653503465146, 35267.4709879352, 36185.457218141746, 16112.19439028044, 16131.758023629654, 16312.184390780414, 16367.345306187857, 16376.918115409586, 11191.2725672831, 11912.0, 12404.875951240372, 12517.49930002808, 12528.498860045678, 13499.595012149652, 15463.0, 19108.617827643367, 19189.0, 19260.0, 7788.4548081634875, 7841.4118941078505, 7925.365970722329, 7978.242067003625, 8021.83410479179, 706.615173788464, 871.7646235516376, 1014.5333146752577, 1021.0606242256993, 1049.4700176411015, 29774.55338169929, 30113.0, 30119.397612048073, 30959.535606965914, 31089.844550777554, 970.088117169858, 1027.306568066552, 1073.2433634287963, 1086.0931122512632, 1111.4553868604326, 12868.742625147444, 15029.572190641871, 15346.923265383602, 15611.687766244839, 15703.764443533357, 577990.110049447, 675109.0, 683806.0, 685429.0, 690124.0, 56326.718366407906, 56562.0, 57002.714986424806, 57165.42834571684, 57526.13710794342, 1336.5789776220458, 1342.1812694256496, 1377.2838124175373, 1377.9173249605055, 1384.0, 29186.7081329184, 29929.251768705955, 30013.763222879952, 30140.84929575338, 31198.22004449907, 40556.0, 49892.75053624854, 49982.25026624531, 50013.24980125374, 50100.74949625228, 482760.0, 575837.0, 576321.0, 576908.0, 577900.0, 25987.870060650333, 26109.347266318495, 26404.603930941437, 27129.72870271351, 27852.30369240785, 48266.0, 48571.0, 49116.50883491262, 49386.506134938194, 50093.0, 35375.408106635776, 36022.0, 37486.812565937, 39533.40699889562, 40542.79728601338, 36773.26453470862, 38366.0, 39009.80495097506, 40055.99860003523, 40217.59782402139, 38151.04622384463, 38395.6160438392, 38773.41839872348, 38803.61196388, 40290.99272518211, 27074.0, 31158.68841311558, 31487.52768708517, 35053.47419788654, 35063.772767953, 25568.872155639103, 25691.871540642176, 26051.218463446126, 26195.607065893644, 27116.864415677795], "value": 19453.209994922796, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.7222438722183, 375.27384510971257, 382.9253295607356, 383.9596842331553, 402.9697772667049, 15984.84015159848, 19291.807081929175, 20870.89564552179, 21574.0, 21831.781682183173, 20678.48303792406, 20910.477238069056, 21197.470063248427, 21268.4682882928, 21438.785612143874, 5770.019096753541, 6080.270367555878, 6082.178905847721, 6090.939090609104, 6108.205933228674, 5709.685967271798, 5931.73307201177, 5966.642001479903, 5982.521398288149, 6051.4856237219665, 5779.682117483537, 5807.0, 5841.912371314434, 5930.673812940287, 5947.167396564484, 5717.885642287151, 5895.852603684899, 5902.970485147568, 5908.704564771787, 5962.4633782959745, 5177.715225662587, 5179.637425380225, 5190.688558686491, 5192.0, 5193.948060519384, 21426.357209283746, 26245.343866403302, 26455.0, 26514.86742566275, 28225.15324540267, 1906.74258975038, 2061.701053347256, 2082.323244945399, 2143.8284937205144, 2597.467519158587, 8622.65509379624, 10490.79018419635, 13070.673233169151, 14571.417143314255, 15219.391224351013, 1863.7204419337072, 1873.1570793143003, 1915.7413749143827, 1931.94204173875, 1944.4069558784706, 128225.0, 133893.0, 134769.0, 136497.3175134128, 141141.2942935289, 11390.202685811913, 11439.656810295704, 11658.41707914601, 11861.347625880659, 11867.465964031639, 11842.171048026728, 12923.353832308347, 13595.796063059062, 14424.567262982127, 14426.927865360605, 7069.540479868792, 8430.494170349799, 8559.914400855912, 8611.095834937367, 8641.870371944426, 8147.551884646283, 8440.535770532557, 8446.155384461505, 8504.149585041447, 8590.527520986405, 3487.7035451986358, 4543.977280113579, 4548.135854187693, 4577.519360467103, 4622.607078398374, 1597.4249270262696, 1913.416407995547, 1922.1542521290587, 1942.4366933589383, 1944.3000519812856, 849.4096602861076, 854.7521218846589, 901.7735879204276, 937.2408349237004, 997.5411310796969, 16922.915385422995, 20017.699734503993, 20310.695339569917, 20581.794182057987, 20616.69074963877, 861.6773253056529, 875.4484674654926, 878.7275944457111, 892.2148509311894, 911.539672465414, 9528.714138575853, 10540.472976351151, 10917.39954302521, 10922.399268040333, 10964.56141754321, 448123.0, 552447.0, 597126.0, 609045.0, 630247.0, 130795.0, 138834.0, 141003.2949835265, 142106.289468552, 144803.0, 959.0649117110761, 966.5602151021268, 982.9286078174824, 984.9261305401981, 988.1551273660916, 18613.627727445648, 18621.44135675932, 18795.624087518445, 18896.3386281485, 18935.71596426027, 55639.0, 56354.1546876789, 57371.71314143569, 58109.83780324455, 59175.0, 67415.0, 77999.0, 80272.59863700643, 80656.790148149, 83038.0, 6975.755848545276, 7308.707651693872, 7421.443391745533, 7561.2060733622175, 8186.918130818615, 11141.72145696364, 11460.656180314603, 12946.80579791285, 13537.79693304621, 13716.588502344946, 11095.833562496731, 11272.549098036316, 11462.770744585228, 11766.941165294118, 11889.0, 10721.41032243203, 10762.838557421488, 11149.99650031501, 11301.943490282496, 11474.94262528682, 11531.596394126165, 11625.88374116282, 11920.701982450508, 11986.520539178335, 12003.279803211835, 7386.926130738624, 7438.888416673863, 7531.058617672791, 7654.73208437702, 7660.616969151632, 8445.902032735705, 10088.940661230465, 10820.945895270474, 11074.446277686244, 11477.713057173303], "value": 9554.008682193631, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.9392824287033, 1567.255553612034, 1770.1503278426355, 1839.1999480226095, 1886.8207520285578, 8012.078610959741, 8389.203025712563, 8634.050254472004, 8925.776855578613, 8945.194932456086, 8670.913290867089, 8781.517016564087, 8791.560421978907, 8800.515971621558, 8809.29525637949, 2318.791308782205, 2361.244401791427, 2362.126013375054, 2363.669086327907, 2368.1948137633203, 1887.4337698690406, 1958.6670266054805, 2363.8936247868887, 2368.0054377161546, 2372.632242002484, 2304.0783686525356, 2340.2862127051244, 2355.5759963206615, 2361.6103342948395, 2377.7622237776172, 2300.631898896177, 2331.7901388875, 2336.4158960259933, 2342.8711420871846, 2349.3656712687566, 2339.543788961153, 2346.260927807752, 2349.7767712067325, 2353.51752890657, 2363.9645405318934, 8934.151255630704, 8937.955310223473, 8951.955240223757, 8984.056674049261, 8995.595198216097, 4500.212462819027, 5303.893922121536, 5387.649802762847, 5388.865278368033, 5402.135658294654, 3444.345574340867, 3506.281212351462, 3509.526213961108, 3583.175869550018, 3635.2729454109285, 890.5057692980394, 901.986470202941, 1031.9071283584512, 1088.2708585247824, 1088.515610553304, 11120.499577519031, 11442.7985061569, 11568.363739994296, 11590.362530060844, 11594.014508766764, 4567.634589232854, 4575.473820510617, 4769.260764581495, 4771.976140119277, 4776.498467660846, 7917.722879699298, 10022.0, 10047.04553067472, 10047.648332308334, 10250.0, 5321.680699158062, 5324.227986941872, 5359.678419294777, 5362.463753624606, 5367.302250707383, 4396.912061758747, 4693.812247510062, 4909.705417674951, 4909.729964851896, 4913.606911447076, 3897.9610203897596, 3933.4296527003426, 4007.1785284016705, 4035.9798201008807, 4071.75569465833, 1078.2506158219962, 1271.167385362589, 1294.3140135728079, 1299.7465494228725, 1300.206873806977, 827.5655280977535, 838.7022606974558, 842.2377748137945, 912.7170577121113, 974.5030034682221, 5554.166874968706, 5581.6371935824045, 5863.2670916135485, 5887.587868849225, 6020.518358531307, 434.86519179054596, 442.95348988356403, 449.07490569427085, 451.3387886745933, 452.28087341127764, 3450.861965521351, 3884.3590807517007, 3966.6231707987695, 4052.8378864845668, 4061.878143655695, 10054.64808731691, 10493.055624993634, 10556.155507559377, 10556.788864222672, 10727.678169654922, 9428.15146636806, 10213.693589192337, 10539.894601053891, 10633.468326583794, 10645.988631080036, 8043.638036288381, 8129.593520323961, 8130.959345203236, 8178.386621003448, 8251.29863961558, 4750.382450281441, 5224.190250511177, 5472.507474327171, 5823.708814559171, 5884.764609415575, 9752.60989560438, 9909.603615855285, 10008.549615267477, 10048.296619236875, 10074.093331600192, 10043.0, 10111.54498047575, 10224.386536807815, 10242.53908574131, 10253.948730256301, 7049.541779784297, 7395.149557800922, 7531.209223031503, 7570.659320330488, 7713.845723085395, 8513.74458766238, 8523.616437260462, 8599.183077607617, 8616.310695144248, 8635.525046122524, 7368.6315684214505, 7372.926270737438, 7520.8871866920945, 7574.5076570022775, 7594.734184303523, 7353.374963128194, 7436.330730234305, 7502.024736784401, 7575.356094732009, 7586.924130758622, 7031.929680703128, 7125.501214914906, 7145.714171433085, 7147.928520714726, 7159.964200179174, 4088.7955602220363, 5015.84952451427, 5061.392632884077, 5062.31658726082, 5110.207917772751, 4938.1358262304675, 4952.947496170099, 5061.670991385548, 5139.922901156411, 5184.948150518447], "value": 4466.2274453668615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.26891502329147, 304.26216425168957, 310.0867943905199, 312.1649587353828, 313.61268832991254, 4674.883127921804, 4950.826721064755, 5303.23103150043, 5641.323041235048, 5706.857328566788, 5526.58550608704, 5543.944560554393, 5574.770091963207, 5617.354004289508, 5621.915671264935, 3871.128995975897, 3906.921861562767, 4222.577742225783, 4244.936325955113, 4256.723312984662, 4123.824709957663, 4193.853215137471, 4209.789510524477, 4251.4898212214575, 4283.528811830712, 3595.964040359589, 4156.480439945007, 4165.1669666066755, 4169.749815011094, 4231.196072746168, 4202.235061274288, 4204.957950420488, 4209.326507758744, 4223.043869291478, 4237.279662457389, 2866.899658511942, 2971.747401470856, 3649.908752281188, 3661.7619854709624, 3681.0981309579324, 4761.59526440253, 4929.2359684248995, 5160.690358578459, 5389.272448219519, 5472.5621950243885, 4269.402283680287, 4636.629069674418, 4796.56830885222, 4800.375951126366, 4803.927941080887, 4765.832371069076, 5445.008660053516, 5842.9908597072545, 5860.120981852756, 5866.618669786493, 3313.353895990283, 3407.6710083067624, 3891.2217556488818, 4016.3172260715746, 4024.3158663027357, 5364.302640656729, 6185.288691800411, 6193.6903154842075, 6219.751209951596, 6230.719617617218, 3549.4853246279145, 4061.634452899253, 4078.286299897506, 4079.9592004080173, 4094.529129150126, 3689.5941446441407, 3745.7752534847996, 3857.4599556062176, 3985.70107241958, 4156.173801814734, 4650.139724150975, 4695.24876019842, 4723.929141062887, 4745.335653008581, 4767.95232047682, 4833.734144622009, 5054.82308119214, 5900.970495147497, 5969.134475501115, 5987.371326010793, 1296.241698606307, 1329.3286890120621, 1336.6524703576945, 1355.3223388305846, 1361.685973036025, 778.9766307010799, 781.9022622172229, 891.9018907920124, 903.8508646073456, 917.1791246834047, 4743.537217831003, 4755.00289878252, 4756.524347565285, 5362.70505122222, 5473.534749546254, 5103.566196873233, 5734.964087748873, 6000.309964354068, 6024.3072046714315, 6053.182820319289, 4611.054733779567, 4900.142475066849, 4992.2761199626575, 5263.499967503081, 5439.456054394529, 2331.4870728439714, 2387.9641805372935, 2500.2124330835727, 2623.622598135994, 2712.972870271272, 4909.582685471775, 5075.390953085654, 5266.631335806457, 5270.183121616155, 5367.597430192673, 4832.49258827818, 4858.78135483904, 4941.332920055746, 5201.739913004335, 5262.815801447007, 4402.71382360152, 4670.859874203779, 4831.396075490564, 5039.462963796004, 5274.419813820554, 5012.4736902626155, 5070.4929507049, 5144.845654630367, 5154.61340399464, 5157.690538567548, 4105.794710264415, 4202.810873510638, 5001.399832020181, 5096.623911543788, 5933.821985340447, 6119.357467465852, 6186.381361863778, 6284.585968157128, 6289.245290564979, 6309.652969086561, 3364.5626068610923, 3962.782046987328, 3993.540742814497, 4001.779902105412, 4013.7190396671954, 5704.771809127755, 5778.335491418541, 5986.970065149646, 6072.483838873569, 6073.514118870391, 5757.568182386254, 5936.940630593639, 5972.462478376967, 5980.9401905980385, 5993.370696077023, 5972.8805423892145, 5977.581569290108, 5992.2809262886985, 6007.197840647701, 6014.646704491454, 4624.491305956275, 4719.2921061841, 5770.278715160605, 5791.681457519709, 5857.560682948711, 5172.844814655567, 5819.592628515963, 5960.314563825043, 5963.2844058713235, 5973.372795856372, 5338.505218538815, 5470.23753004746, 5511.944880551143, 5835.4748072673665, 5837.29952405714], "value": 4110.177251555156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.444832426654, 699.4439420660574, 699.9465803965032, 773.5010917957917, 823.7355659063337, 12033.939830300847, 12829.807552886703, 16119.113448760314, 16156.03063816172, 17114.572135696613, 13491.325433728323, 16467.094309812954, 16594.253258603363, 16669.33322667092, 16682.082485463325, 831.5509624802614, 854.6495936665937, 857.4340934982913, 857.5283594023293, 858.9312854971619, 684.907537482441, 773.2499475508747, 839.08539691736, 857.0101532729676, 872.1670804381832, 876.7676565710092, 885.8626912828489, 891.9777005574848, 916.102219824569, 916.1662886773038, 890.8307421589909, 909.5088652127843, 910.3627460777416, 910.517425764346, 910.9544522773868, 627.3130921640796, 658.3646780856449, 666.1140682891743, 676.5940435738567, 677.7864972533636, 15500.22498875063, 15662.138582377964, 15781.368745250176, 15807.130607816565, 15888.523344299689, 14497.202653854034, 14518.201498917555, 14528.636784080376, 14538.200398978051, 14657.560273191715, 11962.897421112362, 12139.028877689763, 12139.757204855854, 12196.0, 12341.75316493665, 3865.942010869839, 3900.7854567998747, 3903.238868420659, 3911.9804400977814, 4047.150098479323, 123858.38070809678, 124795.0, 126178.0, 126558.36720816429, 126730.0, 8727.301815854717, 11118.722031949266, 11121.110311175087, 11142.610008649659, 11224.66326010221, 22817.88591057034, 22980.770192297863, 23012.76987230106, 23070.7692923072, 23076.0, 7616.771496855104, 8134.75595732129, 8136.186381361935, 8364.749057528285, 8415.200555947175, 4489.461264648197, 4559.566841150152, 4560.17916774977, 4597.42532183477, 4674.485806561275, 3652.397354436488, 3721.199942012426, 3766.3597188478025, 3769.754965927206, 3773.8490460381277, 653.1182903080897, 662.9834254143685, 663.4228221447372, 667.9098321726602, 675.2100042949761, 593.1132956230377, 595.9910601340983, 612.4334990134108, 665.4609766089483, 703.6341102626606, 7574.924250757422, 8807.854978852709, 9178.758414360509, 9438.764030899145, 9666.984966578408, 656.1699450195506, 672.2840175213382, 678.5369110130196, 681.6489507903434, 688.6625553478859, 4376.978115109468, 4636.79443344726, 4670.579647831643, 4689.718616882929, 4707.105649926503, 120685.0, 152788.0, 166877.16561417116, 170330.0, 172780.0, 103510.0, 122638.5472290567, 132062.0, 132369.0, 148263.0, 116256.0, 117514.0, 119032.0, 125448.99999999818, 125485.74514254923, 7233.638318083969, 8185.0, 8911.844089862583, 9025.0, 9060.95798983099, 47027.82430439266, 61124.694376527834, 67800.66099669668, 69835.30164698491, 69837.65081174561, 78955.0, 93637.0, 103468.48265758622, 108157.0, 110446.95530446891, 11806.82289765637, 12014.63956081319, 13148.737025259632, 13311.600651980456, 13391.598252052454, 14886.253929747001, 15305.387784488496, 15389.0, 15524.534263972098, 15871.444499442465, 14175.787363189767, 14481.131132132106, 14633.634159146106, 14644.780328295297, 14903.180325082225, 14088.943329250142, 14283.500077497238, 14339.498117565836, 14341.139531628136, 14824.332905019515, 13585.646257147997, 13642.386092625657, 13647.590572282847, 13858.861411385757, 14284.642883927985, 11420.428978550874, 11443.485043173243, 11560.479778409823, 11622.360770157722, 11870.228435151688, 8311.0, 9641.907384205508, 10084.848727269244, 10468.68593942183, 11414.258073225214], "value": 7978.424620720833, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 108.0, 118.0, 118.0, 118.0, 113.0, 118.0, 118.0, 119.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 134.0, 195.0, 143.0, 125.0, 161.0, 144.0, 198.0, 108.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 196.0, 213.0, 216.0, 196.0, 197.0, 195.0, 202.0, 197.0, 189.0], "value": 199.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 76.0, 142.0, 59.0, 57.0, 60.0, 62.0, 143.0, 60.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 96.0, 154.0, 76.0, 72.0, 79.0, 118.0, 87.0, 104.0, 143.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 93.0, 90.0, 129.0, 88.0, 105.0, 115.0, 92.0, 89.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 97.0, 111.0, 146.0, 109.0, 104.0, 111.0, 110.0, 107.0, 130.0], "value": 117.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 145.0, 110.0, 129.0, 146.0, 151.0, 96.0, 123.0, 160.0, 87.0], "value": 127.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 57.0, 57.0, 58.0, 58.0, 58.0, 55.0, 58.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 80.0, 77.0, 83.0, 81.0, 78.0, 64.0, 73.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 88.0, 88.0, 85.0, 86.0, 83.0, 87.0, 85.0, 90.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 162.0, 147.0, 177.0, 163.0, 161.0, 134.0, 142.0, 158.0, 170.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 170.0, 171.0, 173.0, 168.0, 169.0, 175.0, 168.0, 168.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 70.0, 67.0, 67.0, 67.0, 69.0, 69.0, 70.0, 77.0], "value": 69.7, "unit": "score"}]}]} 11:11:51 INFO - Return code: 0 11:11:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:51 ERROR - # TBPL SUCCESS # 11:11:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:11:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:11:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:11:51 INFO - 2016-08-12 11:11:51.755 screenresolution[4944:26924] starting screenresolution argv=screenresolution get 11:11:51 INFO - 2016-08-12 11:11:51.758 screenresolution[4944:26924] Display 0: 1600x1200x32@60 11:11:51 INFO - 2016-08-12 11:11:51.764 screenresolution[4945:26927] starting screenresolution argv=screenresolution list 11:11:51 INFO - Available Modes on Display 0 11:11:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:11:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:11:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:11:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:11:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:11:52 INFO - Intel Iris: 11:11:52 INFO - Chipset Model: Intel Iris 11:11:52 INFO - Type: GPU 11:11:52 INFO - Bus: Built-In 11:11:52 INFO - VRAM (Dynamic, Max): 1536 MB 11:11:52 INFO - Vendor: Intel (0x8086) 11:11:52 INFO - Device ID: 0x0a2e 11:11:52 INFO - Revision ID: 0x0009 11:11:52 INFO - Displays: 11:11:52 INFO - Display: 11:11:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:11:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:11:52 INFO - Display Serial Number: 1600x1200 60 11:11:52 INFO - Main Display: Yes 11:11:52 INFO - Mirror: Off 11:11:52 INFO - Online: Yes 11:11:52 INFO - Rotation: Supported 11:11:52 INFO - Return code: 0 11:11:52 INFO - Running post-action listener: _resource_record_post_action 11:11:52 INFO - [mozharness: 2016-08-12 18:11:52.009953Z] Finished run-tests step (success) 11:11:52 INFO - Running post-run listener: _resource_record_post_run 11:11:52 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 31439872; Write bytes: 705568768; Read time: 188; Write time: 1994 11:11:52 INFO - TinderboxPrint: CPU usage
54.3% 11:11:52 INFO - TinderboxPrint: I/O read bytes / time
31,439,872 / 188 11:11:52 INFO - TinderboxPrint: I/O write bytes / time
705,568,768 / 1,994 11:11:52 INFO - TinderboxPrint: CPU idle
2,212.9 (45.7%) 11:11:52 INFO - TinderboxPrint: CPU system
979.6 (20.2%) 11:11:52 INFO - TinderboxPrint: CPU user
1,649.2 (34.1%) 11:11:52 INFO - TinderboxPrint: Swap in / out
430,546,944 / 0 11:11:52 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 401488384; Write bytes: 395097600; Read time: 31109; Write time: 790 11:11:52 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29346816; Write bytes: 298469888; Read time: 175; Write time: 1165 11:11:52 INFO - Running post-run listener: _upload_blobber_files 11:11:52 INFO - Blob upload gear active. 11:11:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11:52 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:11:52 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:11:52 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:11:52 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:54 INFO - (blobuploader) - INFO - Done attempting. 11:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:55 INFO - (blobuploader) - INFO - Done attempting. 11:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:57 INFO - (blobuploader) - INFO - Done attempting. 11:11:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:57 INFO - Return code: 0 11:11:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/17fa5f3b9e02766b13138cbdfe4750754c2b10c8467b84f23e78921ef32ee5e3086b662f41b1e0314daed0d1831eee9dd5f5f941ce3dc10722ea81c0dec9da32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2f1274e128ca0493819867d5673400745329233948a9c460b6ff87b7e7af9fac3850c7a6641c8f228d437fad6a7a71db1e8782abdc139a4b93d90c181600685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d31b2a4533dd8d2f7546884c201feacc80699a112b6fe32ac33ecaa67a32c3acb19aa6385a1394e6fa8db81ca43f0e891612f1e0793978bf1f3d1da53954d9c9"} 11:11:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:57 INFO - Contents: 11:11:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/17fa5f3b9e02766b13138cbdfe4750754c2b10c8467b84f23e78921ef32ee5e3086b662f41b1e0314daed0d1831eee9dd5f5f941ce3dc10722ea81c0dec9da32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2f1274e128ca0493819867d5673400745329233948a9c460b6ff87b7e7af9fac3850c7a6641c8f228d437fad6a7a71db1e8782abdc139a4b93d90c181600685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d31b2a4533dd8d2f7546884c201feacc80699a112b6fe32ac33ecaa67a32c3acb19aa6385a1394e6fa8db81ca43f0e891612f1e0793978bf1f3d1da53954d9c9"} 11:11:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:57 INFO - Copying logs to upload dir... 11:11:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.939459 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2016-08-12 11:11:57.403745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 11:11:57.408024) ========= 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.soUW6aUDzm/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.W6qrWB3QYa/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/17fa5f3b9e02766b13138cbdfe4750754c2b10c8467b84f23e78921ef32ee5e3086b662f41b1e0314daed0d1831eee9dd5f5f941ce3dc10722ea81c0dec9da32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2f1274e128ca0493819867d5673400745329233948a9c460b6ff87b7e7af9fac3850c7a6641c8f228d437fad6a7a71db1e8782abdc139a4b93d90c181600685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d31b2a4533dd8d2f7546884c201feacc80699a112b6fe32ac33ecaa67a32c3acb19aa6385a1394e6fa8db81ca43f0e891612f1e0793978bf1f3d1da53954d9c9"} build_url:https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/GnlgIsbZTb2De_3d1NteJA/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/17fa5f3b9e02766b13138cbdfe4750754c2b10c8467b84f23e78921ef32ee5e3086b662f41b1e0314daed0d1831eee9dd5f5f941ce3dc10722ea81c0dec9da32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2f1274e128ca0493819867d5673400745329233948a9c460b6ff87b7e7af9fac3850c7a6641c8f228d437fad6a7a71db1e8782abdc139a4b93d90c181600685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d31b2a4533dd8d2f7546884c201feacc80699a112b6fe32ac33ecaa67a32c3acb19aa6385a1394e6fa8db81ca43f0e891612f1e0793978bf1f3d1da53954d9c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 11:11:57.441951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:11:57.442312) ========= 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.soUW6aUDzm/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.W6qrWB3QYa/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005353 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:11:57.499704) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 11:11:57.500071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 11:11:57.500434) ========= ========= Total master_lag: 0.92 =========