builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0301 starttime: 1472646880.44 results: success (0) buildid: 20160831030224 builduid: ddd4f3983d55401b901753c3e704c413 revision: 506facea63169a29e04eb140663da1730052db64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:40.435971) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:40.436405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:40.436702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:40.562114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:40.562375) ========= 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.CvTrPclooW/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.Mt709eSaFB/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-31 05:34:40-- 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% 64.7M=0s 2016-08-31 05:34:41 (64.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.896888 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:41.481733) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:41.482015) ========= 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.CvTrPclooW/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.Mt709eSaFB/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.021060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:41.529121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 05:34:41.529431) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 506facea63169a29e04eb140663da1730052db64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 506facea63169a29e04eb140663da1730052db64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CvTrPclooW/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.Mt709eSaFB/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-31 05:34:41,615 truncating revision to first 12 chars 2016-08-31 05:34:41,615 Setting DEBUG logging. 2016-08-31 05:34:41,615 attempt 1/10 2016-08-31 05:34:41,615 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/506facea6316?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 05:34:42,820 unpacking tar archive at: mozilla-central-506facea6316/testing/mozharness/ program finished with exit code 0 elapsedTime=1.463822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 05:34:43.015858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:43.016162) ========= script_repo_revision: 506facea63169a29e04eb140663da1730052db64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:43.016550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:43.016839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 05:34:43.035236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-31 05:34:43.035510) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CvTrPclooW/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.Mt709eSaFB/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:34:43 INFO - MultiFileLogger online at 20160831 05:34:43 in /builds/slave/test 05:34:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:34:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:34:43 INFO - {'append_to_log': False, 05:34:43 INFO - 'base_work_dir': '/builds/slave/test', 05:34:43 INFO - 'blob_upload_branch': 'Firefox', 05:34:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:34:43 INFO - 'branch': 'Firefox', 05:34:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:43 INFO - 'config_files': ('talos/mac_config.py',), 05:34:43 INFO - 'default_actions': ('clobber', 05:34:43 INFO - 'read-buildbot-config', 05:34:43 INFO - 'download-and-extract', 05:34:43 INFO - 'populate-webroot', 05:34:43 INFO - 'create-virtualenv', 05:34:43 INFO - 'install', 05:34:43 INFO - 'run-tests'), 05:34:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:43 INFO - 'download_minidump_stackwalk': True, 05:34:43 INFO - 'download_symbols': 'ondemand', 05:34:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:43 INFO - 'installer_path': 'installer.exe', 05:34:43 INFO - 'log_level': 'info', 05:34:43 INFO - 'log_name': 'talos', 05:34:43 INFO - 'log_to_console': True, 05:34:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:34:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:34:43 INFO - 'opt_config_files': (), 05:34:43 INFO - 'pip_index': False, 05:34:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:43 INFO - 'cmd': ('bash', 05:34:43 INFO - '-c', 05:34:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:43 INFO - 'enabled': True, 05:34:43 INFO - 'halt_on_failure': False, 05:34:43 INFO - 'name': 'check_screen_resolution'},), 05:34:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:43 INFO - 'cmd': ('bash', 05:34:43 INFO - '-c', 05:34:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:43 INFO - 'enabled': True, 05:34:43 INFO - 'halt_on_failure': False, 05:34:43 INFO - 'name': 'check_screen_resolution'},), 05:34:43 INFO - 'run_cmd_checks_enabled': True, 05:34:43 INFO - 'sps_profile': False, 05:34:43 INFO - 'sps_profile_interval': 0, 05:34:43 INFO - 'suite': 'dromaeojs-e10s', 05:34:43 INFO - 'system_bits': '32', 05:34:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:43 INFO - 'title': 't-yosemite-r7-0301', 05:34:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:43 INFO - 'use_talos_json': True, 05:34:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:34:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:43 INFO - 'work_dir': 'build'} 05:34:43 INFO - [mozharness: 2016-08-31 12:34:43.229943Z] Running clobber step. 05:34:43 INFO - Running pre-action listener: _resource_record_pre_action 05:34:43 INFO - Running main action method: clobber 05:34:43 INFO - rmtree: /builds/slave/test/build 05:34:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:34:43 INFO - Running post-action listener: _resource_record_post_action 05:34:43 INFO - [mozharness: 2016-08-31 12:34:43.420666Z] Finished clobber step (success) 05:34:43 INFO - [mozharness: 2016-08-31 12:34:43.420742Z] Running read-buildbot-config step. 05:34:43 INFO - Running pre-action listener: _resource_record_pre_action 05:34:43 INFO - Running main action method: read_buildbot_config 05:34:43 INFO - Using buildbot properties: 05:34:43 INFO - { 05:34:43 INFO - "project": "", 05:34:43 INFO - "product": "firefox", 05:34:43 INFO - "script_repo_revision": "production", 05:34:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:34:43 INFO - "repository": "", 05:34:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:34:43 INFO - "buildid": "20160831030224", 05:34:43 INFO - "stage_platform": "macosx64", 05:34:43 INFO - "basedir": "/builds/slave/test", 05:34:43 INFO - "nightly_build": "True", 05:34:43 INFO - "buildnumber": 52, 05:34:43 INFO - "slavename": "t-yosemite-r7-0301", 05:34:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:34:43 INFO - "platform": "yosemite_r7", 05:34:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:34:43 INFO - "branch": "mozilla-central", 05:34:43 INFO - "repo_path": "mozilla-central", 05:34:43 INFO - "revision": "506facea63169a29e04eb140663da1730052db64", 05:34:43 INFO - "pgo_build": "False", 05:34:43 INFO - "builduid": "ddd4f3983d55401b901753c3e704c413", 05:34:43 INFO - "slavebuilddir": "test" 05:34:43 INFO - } 05:34:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:34:43 INFO - Running post-action listener: _resource_record_post_action 05:34:43 INFO - [mozharness: 2016-08-31 12:34:43.424269Z] Finished read-buildbot-config step (success) 05:34:43 INFO - [mozharness: 2016-08-31 12:34:43.424382Z] Running download-and-extract step. 05:34:43 INFO - Running pre-action listener: _resource_record_pre_action 05:34:43 INFO - Running main action method: download_and_extract 05:34:43 INFO - mkdir: /builds/slave/test/build/tests 05:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:43 INFO - trying https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:34:43 INFO - Downloading https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:34:44 INFO - Downloaded 1199 bytes. 05:34:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:34:44 INFO - Using the following test package requirements: 05:34:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:34:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:34:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:34:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'jsshell-mac.zip'], 05:34:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:34:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:34:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:34:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:34:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:34:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:34:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:44 INFO - trying https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:34:48 INFO - Downloaded 16390794 bytes. 05:34:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:34:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:55 INFO - trying https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:34:56 INFO - Downloaded 16390794 bytes. 05:34:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:02 INFO - trying https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:35:02 INFO - Downloading https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:35:04 INFO - Downloaded 14413998 bytes. 05:35:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:04 INFO - trying https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:35:10 INFO - Downloaded 111691794 bytes. 05:35:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:10 INFO - mkdir: /builds/slave/test/properties 05:35:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:10 INFO - Contents: 05:35:10 INFO - build_url:https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:11 INFO - Running post-action listener: _resource_record_post_action 05:35:11 INFO - Running post-action listener: set_extra_try_arguments 05:35:11 INFO - [mozharness: 2016-08-31 12:35:11.373756Z] Finished download-and-extract step (success) 05:35:11 INFO - [mozharness: 2016-08-31 12:35:11.373907Z] Running populate-webroot step. 05:35:11 INFO - Running pre-action listener: _resource_record_pre_action 05:35:11 INFO - Running main action method: populate_webroot 05:35:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:11 INFO - '--tppagecycles', 05:35:11 INFO - '7'], 05:35:11 INFO - 'tests': ['tsvgm']}}, 05:35:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['damp', 'tps']}, 05:35:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'tests': ['damp', 'tps']}, 05:35:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['dromaeo_dom']}, 05:35:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['basic_compositor_video']}, 05:35:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:35:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['a11yr', 05:35:11 INFO - 'ts_paint', 05:35:11 INFO - 'tpaint', 05:35:11 INFO - 'sessionrestore', 05:35:11 INFO - 'sessionrestore_no_auto_restore', 05:35:11 INFO - 'tabpaint']}, 05:35:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:11 INFO - 'ts_paint', 05:35:11 INFO - 'tpaint', 05:35:11 INFO - 'sessionrestore', 05:35:11 INFO - 'sessionrestore_no_auto_restore', 05:35:11 INFO - 'tabpaint']}, 05:35:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:11 INFO - 'ts_paint', 05:35:11 INFO - 'tpaint', 05:35:11 INFO - 'sessionrestore', 05:35:11 INFO - 'sessionrestore_no_auto_restore', 05:35:11 INFO - 'tabpaint']}, 05:35:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:11 INFO - 'ts_paint', 05:35:11 INFO - 'tpaint', 05:35:11 INFO - 'sessionrestore', 05:35:11 INFO - 'sessionrestore_no_auto_restore', 05:35:11 INFO - 'tabpaint']}, 05:35:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['a11yr', 05:35:11 INFO - 'ts_paint', 05:35:11 INFO - 'tpaint', 05:35:11 INFO - 'sessionrestore', 05:35:11 INFO - 'sessionrestore_no_auto_restore', 05:35:11 INFO - 'tabpaint']}, 05:35:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['a11yr', 05:35:11 INFO - 'ts_paint', 05:35:11 INFO - 'tpaint', 05:35:11 INFO - 'sessionrestore', 05:35:11 INFO - 'sessionrestore_no_auto_restore', 05:35:11 INFO - 'tabpaint']}, 05:35:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['tsvgx', 05:35:11 INFO - 'tsvgr_opacity', 05:35:11 INFO - 'tart', 05:35:11 INFO - 'tscrollx', 05:35:11 INFO - 'cart']}, 05:35:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:11 INFO - 'tsvgr_opacity', 05:35:11 INFO - 'tart', 05:35:11 INFO - 'tscrollx', 05:35:11 INFO - 'cart']}, 05:35:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'talos_options': ['--disable-e10s'], 05:35:11 INFO - 'tests': ['tp5o']}, 05:35:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'tests': ['tp5o']}, 05:35:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'talos_options': ['--disable-e10s', 05:35:11 INFO - '--xperf_path', 05:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:11 INFO - 'tests': ['tp5n']}, 05:35:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:11 INFO - 'talos_options': ['--xperf_path', 05:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:11 INFO - 'tests': ['tp5n']}}, 05:35:11 INFO - 'talos.zip': {'path': '', 05:35:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:11 INFO - Running post-action listener: _resource_record_post_action 05:35:11 INFO - [mozharness: 2016-08-31 12:35:11.392643Z] Finished populate-webroot step (success) 05:35:11 INFO - [mozharness: 2016-08-31 12:35:11.392748Z] Running create-virtualenv step. 05:35:11 INFO - Running pre-action listener: _resource_record_pre_action 05:35:11 INFO - Running main action method: create_virtualenv 05:35:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:35:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:11 INFO - Using real prefix '/tools/python27' 05:35:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:15 INFO - Installing pip.................done. 05:35:15 INFO - Return code: 0 05:35:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:15 INFO - 'HOME': '/Users/cltbld', 05:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:15 INFO - 'LOGNAME': 'cltbld', 05:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:15 INFO - 'MOZ_NO_REMOTE': '1', 05:35:15 INFO - 'NO_EM_RESTART': '1', 05:35:15 INFO - 'PAGER': '/bin/cat', 05:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:15 INFO - 'PWD': '/builds/slave/test', 05:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:15 INFO - 'SHELL': '/bin/bash', 05:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:15 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:15 INFO - 'USER': 'cltbld', 05:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:15 INFO - 'XPC_FLAGS': '0x0', 05:35:15 INFO - 'XPC_SERVICE_NAME': '0', 05:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:35:15 INFO - Cleaning up... 05:35:15 INFO - Return code: 0 05:35:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:15 INFO - 'HOME': '/Users/cltbld', 05:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:15 INFO - 'LOGNAME': 'cltbld', 05:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:15 INFO - 'MOZ_NO_REMOTE': '1', 05:35:15 INFO - 'NO_EM_RESTART': '1', 05:35:15 INFO - 'PAGER': '/bin/cat', 05:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:15 INFO - 'PWD': '/builds/slave/test', 05:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:15 INFO - 'SHELL': '/bin/bash', 05:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:15 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:15 INFO - 'USER': 'cltbld', 05:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:15 INFO - 'XPC_FLAGS': '0x0', 05:35:15 INFO - 'XPC_SERVICE_NAME': '0', 05:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:15 INFO - Downloading/unpacking psutil>=3.1.1 05:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:19 INFO - Installing collected packages: psutil 05:35:19 INFO - Running setup.py install for psutil 05:35:19 INFO - building 'psutil._psutil_osx' extension 05:35:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:35:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:35:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:35:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:35:19 INFO - building 'psutil._psutil_posix' extension 05:35:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:35:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:35:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:35:19 INFO - ^ 05:35:19 INFO - 1 warning generated. 05:35:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:19 INFO - Successfully installed psutil 05:35:19 INFO - Cleaning up... 05:35:19 INFO - Return code: 0 05:35:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:19 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 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:19 INFO - 'HOME': '/Users/cltbld', 05:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:19 INFO - 'LOGNAME': 'cltbld', 05:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:19 INFO - 'MOZ_NO_REMOTE': '1', 05:35:19 INFO - 'NO_EM_RESTART': '1', 05:35:19 INFO - 'PAGER': '/bin/cat', 05:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:19 INFO - 'PWD': '/builds/slave/test', 05:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:19 INFO - 'SHELL': '/bin/bash', 05:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:19 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:19 INFO - 'USER': 'cltbld', 05:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:19 INFO - 'XPC_FLAGS': '0x0', 05:35:19 INFO - 'XPC_SERVICE_NAME': '0', 05:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:35:22 INFO - Installing collected packages: mozsystemmonitor 05:35:22 INFO - Running setup.py install for mozsystemmonitor 05:35:22 INFO - Successfully installed mozsystemmonitor 05:35:22 INFO - Cleaning up... 05:35:22 INFO - Return code: 0 05:35:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:22 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 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:22 INFO - 'HOME': '/Users/cltbld', 05:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:22 INFO - 'LOGNAME': 'cltbld', 05:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:22 INFO - 'MOZ_NO_REMOTE': '1', 05:35:22 INFO - 'NO_EM_RESTART': '1', 05:35:22 INFO - 'PAGER': '/bin/cat', 05:35:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:22 INFO - 'PWD': '/builds/slave/test', 05:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:22 INFO - 'SHELL': '/bin/bash', 05:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:22 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:22 INFO - 'USER': 'cltbld', 05:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:22 INFO - 'XPC_FLAGS': '0x0', 05:35:22 INFO - 'XPC_SERVICE_NAME': '0', 05:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:26 INFO - warning: no files found matching '*.txt' 05:35:26 INFO - no previously-included directories found matching 'build' 05:35:26 INFO - no previously-included directories found matching 'dist' 05:35:26 INFO - no previously-included directories found matching '.git*' 05:35:26 INFO - Installing collected packages: jsonschema, functools32 05:35:26 INFO - Running setup.py install for functools32 05:35:26 INFO - warning: no files found matching '*.txt' 05:35:26 INFO - no previously-included directories found matching 'build' 05:35:26 INFO - no previously-included directories found matching 'dist' 05:35:26 INFO - no previously-included directories found matching '.git*' 05:35:26 INFO - Successfully installed jsonschema functools32 05:35:26 INFO - Cleaning up... 05:35:26 INFO - Return code: 0 05:35:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:26 INFO - 'HOME': '/Users/cltbld', 05:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:26 INFO - 'LOGNAME': 'cltbld', 05:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:26 INFO - 'MOZ_NO_REMOTE': '1', 05:35:26 INFO - 'NO_EM_RESTART': '1', 05:35:26 INFO - 'PAGER': '/bin/cat', 05:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:26 INFO - 'PWD': '/builds/slave/test', 05:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:26 INFO - 'SHELL': '/bin/bash', 05:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:26 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:26 INFO - 'USER': 'cltbld', 05:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:26 INFO - 'XPC_FLAGS': '0x0', 05:35:26 INFO - 'XPC_SERVICE_NAME': '0', 05:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:35:26 INFO - Cleaning up... 05:35:26 INFO - Return code: 0 05:35:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:26 INFO - 'HOME': '/Users/cltbld', 05:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:26 INFO - 'LOGNAME': 'cltbld', 05:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:26 INFO - 'MOZ_NO_REMOTE': '1', 05:35:26 INFO - 'NO_EM_RESTART': '1', 05:35:26 INFO - 'PAGER': '/bin/cat', 05:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:26 INFO - 'PWD': '/builds/slave/test', 05:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:26 INFO - 'SHELL': '/bin/bash', 05:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:26 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:26 INFO - 'USER': 'cltbld', 05:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:26 INFO - 'XPC_FLAGS': '0x0', 05:35:26 INFO - 'XPC_SERVICE_NAME': '0', 05:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:35:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:30 INFO - Downloading docopt-0.6.1.tar.gz 05:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:30 INFO - Running setup.py install for blobuploader 05:35:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:35:30 INFO - Running setup.py install for requests 05:35:31 INFO - Running setup.py install for docopt 05:35:31 INFO - Successfully installed blobuploader requests docopt 05:35:31 INFO - Cleaning up... 05:35:31 INFO - Return code: 0 05:35:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:31 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 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:31 INFO - 'HOME': '/Users/cltbld', 05:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:31 INFO - 'LOGNAME': 'cltbld', 05:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:31 INFO - 'MOZ_NO_REMOTE': '1', 05:35:31 INFO - 'NO_EM_RESTART': '1', 05:35:31 INFO - 'PAGER': '/bin/cat', 05:35:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:31 INFO - 'PWD': '/builds/slave/test', 05:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:31 INFO - 'SHELL': '/bin/bash', 05:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:31 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:31 INFO - 'USER': 'cltbld', 05:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:31 INFO - 'XPC_FLAGS': '0x0', 05:35:31 INFO - 'XPC_SERVICE_NAME': '0', 05:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:31 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-CqpWgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:31 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-da2R0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:31 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-2VRFww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-qjOu89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-O6P4J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Bbg_xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-32ccJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-dkzmW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-hjpeEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-mNG3g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-kbjuEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-TnKkRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-kinBcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-YafFDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-GnKgOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-QBEC8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-_WfPZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:35:33 INFO - Running setup.py install for manifestparser 05:35:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:35:33 INFO - Running setup.py install for mozcrash 05:35:33 INFO - Running setup.py install for mozdebug 05:35:33 INFO - Running setup.py install for mozdevice 05:35:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Running setup.py install for mozfile 05:35:34 INFO - Running setup.py install for mozhttpd 05:35:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Running setup.py install for mozinfo 05:35:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Running setup.py install for mozInstall 05:35:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:35:34 INFO - Running setup.py install for mozleak 05:35:34 INFO - Running setup.py install for mozlog 05:35:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:35:35 INFO - Running setup.py install for moznetwork 05:35:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:35:35 INFO - Running setup.py install for mozprocess 05:35:35 INFO - Running setup.py install for mozprofile 05:35:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:35:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:35:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:35:35 INFO - Running setup.py install for mozrunner 05:35:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:35:35 INFO - Running setup.py install for mozscreenshot 05:35:35 INFO - Running setup.py install for moztest 05:35:35 INFO - Running setup.py install for mozversion 05:35:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:35:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:35:36 INFO - Cleaning up... 05:35:36 INFO - Return code: 0 05:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:36 INFO - 'HOME': '/Users/cltbld', 05:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:36 INFO - 'LOGNAME': 'cltbld', 05:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:36 INFO - 'MOZ_NO_REMOTE': '1', 05:35:36 INFO - 'NO_EM_RESTART': '1', 05:35:36 INFO - 'PAGER': '/bin/cat', 05:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:36 INFO - 'PWD': '/builds/slave/test', 05:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:36 INFO - 'SHELL': '/bin/bash', 05:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:36 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:36 INFO - 'USER': 'cltbld', 05:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:36 INFO - 'XPC_FLAGS': '0x0', 05:35:36 INFO - 'XPC_SERVICE_NAME': '0', 05:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:36 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-QbEofb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:36 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-AyTpA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:36 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-CIyrfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:36 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-QTkzMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:36 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-RRNyWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:36 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-V0nPoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-sAQWBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-7BOwD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-VzwWQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-XiWdee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-0LBe5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-z672Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-oqOVAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Ibrmyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-4_aUzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-lZXTUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-WvysdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:35:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:40 INFO - Downloading blessings-1.6.tar.gz 05:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:35:40 INFO - Installing collected packages: blessings 05:35:40 INFO - Running setup.py install for blessings 05:35:40 INFO - Successfully installed blessings 05:35:40 INFO - Cleaning up... 05:35:40 INFO - Return code: 0 05:35:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:41 INFO - Reading from file tmpfile_stdout 05:35:41 INFO - Current package versions: 05:35:41 INFO - blessings == 1.6 05:35:41 INFO - blobuploader == 1.2.4 05:35:41 INFO - docopt == 0.6.1 05:35:41 INFO - functools32 == 3.2.3-2 05:35:41 INFO - jsonschema == 2.5.1 05:35:41 INFO - manifestparser == 1.1 05:35:41 INFO - mozInstall == 1.12 05:35:41 INFO - mozcrash == 0.17 05:35:41 INFO - mozdebug == 0.1 05:35:41 INFO - mozdevice == 0.48 05:35:41 INFO - mozfile == 1.2 05:35:41 INFO - mozhttpd == 0.7 05:35:41 INFO - mozinfo == 0.9 05:35:41 INFO - mozleak == 0.1 05:35:41 INFO - mozlog == 3.3 05:35:41 INFO - moznetwork == 0.27 05:35:41 INFO - mozprocess == 0.23 05:35:41 INFO - mozprofile == 0.28 05:35:41 INFO - mozrunner == 6.12 05:35:41 INFO - mozscreenshot == 0.1 05:35:41 INFO - mozsystemmonitor == 0.3 05:35:41 INFO - moztest == 0.7 05:35:41 INFO - mozversion == 1.4 05:35:41 INFO - psutil == 3.1.1 05:35:41 INFO - requests == 1.2.3 05:35:41 INFO - wsgiref == 0.1.2 05:35:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:41 INFO - 'HOME': '/Users/cltbld', 05:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:41 INFO - 'LOGNAME': 'cltbld', 05:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:41 INFO - 'MOZ_NO_REMOTE': '1', 05:35:41 INFO - 'NO_EM_RESTART': '1', 05:35:41 INFO - 'PAGER': '/bin/cat', 05:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:41 INFO - 'PWD': '/builds/slave/test', 05:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:41 INFO - 'SHELL': '/bin/bash', 05:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:41 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:41 INFO - 'USER': 'cltbld', 05:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:41 INFO - 'XPC_FLAGS': '0x0', 05:35:41 INFO - 'XPC_SERVICE_NAME': '0', 05:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:35:41 INFO - Cleaning up... 05:35:41 INFO - Return code: 0 05:35:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 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 0x1008c4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100959618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe30b45b610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, '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.CvTrPclooW/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.Mt709eSaFB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:41 INFO - 'HOME': '/Users/cltbld', 05:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:41 INFO - 'LOGNAME': 'cltbld', 05:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:41 INFO - 'MOZ_NO_REMOTE': '1', 05:35:41 INFO - 'NO_EM_RESTART': '1', 05:35:41 INFO - 'PAGER': '/bin/cat', 05:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:41 INFO - 'PWD': '/builds/slave/test', 05:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:41 INFO - 'SHELL': '/bin/bash', 05:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:35:41 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:41 INFO - 'USER': 'cltbld', 05:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:41 INFO - 'XPC_FLAGS': '0x0', 05:35:41 INFO - 'XPC_SERVICE_NAME': '0', 05:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:35:41 INFO - Cleaning up... 05:35:41 INFO - Return code: 0 05:35:41 INFO - Running post-action listener: _resource_record_post_action 05:35:41 INFO - Running post-action listener: _start_resource_monitoring 05:35:41 INFO - Starting resource monitoring. 05:35:41 INFO - [mozharness: 2016-08-31 12:35:41.797976Z] Finished create-virtualenv step (success) 05:35:41 INFO - [mozharness: 2016-08-31 12:35:41.798973Z] Running install step. 05:35:41 INFO - Running pre-action listener: _resource_record_pre_action 05:35:41 INFO - Running main action method: install 05:35:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:42 INFO - Reading from file tmpfile_stdout 05:35:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:35:42 INFO - Reading from file tmpfile_stdout 05:35:42 INFO - Output received: 05:35:42 INFO - Usage: mozinstall [options] installer 05:35:42 INFO - Options: 05:35:42 INFO - -h, --help show this help message and exit 05:35:42 INFO - -d DEST, --destination=DEST 05:35:42 INFO - Directory to install application into. [default: 05:35:42 INFO - "/builds/slave/test"] 05:35:42 INFO - --app=APP Application being installed. [default: firefox] 05:35:42 INFO - mkdir: /builds/slave/test/build/application 05:35:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:36:16 INFO - Reading from file tmpfile_stdout 05:36:16 INFO - Output received: 05:36:16 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:36:16 INFO - Running post-action listener: _resource_record_post_action 05:36:16 INFO - [mozharness: 2016-08-31 12:36:16.748387Z] Finished install step (success) 05:36:16 INFO - [mozharness: 2016-08-31 12:36:16.748554Z] Running run-tests step. 05:36:16 INFO - Running pre-action listener: _resource_record_pre_action 05:36:16 INFO - Running main action method: run_tests 05:36:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:16 INFO - 2016-08-31 05:36:16.763 screenresolution[1988:279695] starting screenresolution argv=screenresolution get 05:36:16 INFO - 2016-08-31 05:36:16.765 screenresolution[1988:279695] Display 0: 1600x1200x32@60 05:36:16 INFO - 2016-08-31 05:36:16.771 screenresolution[1989:279697] starting screenresolution argv=screenresolution list 05:36:16 INFO - Available Modes on Display 0 05:36:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:17 INFO - Intel Iris: 05:36:17 INFO - Chipset Model: Intel Iris 05:36:17 INFO - Type: GPU 05:36:17 INFO - Bus: Built-In 05:36:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:17 INFO - Vendor: Intel (0x8086) 05:36:17 INFO - Device ID: 0x0a2e 05:36:17 INFO - Revision ID: 0x0009 05:36:17 INFO - Displays: 05:36:17 INFO - Display: 05:36:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:17 INFO - Display Serial Number: 1600x1200 60 05:36:17 INFO - Main Display: Yes 05:36:17 INFO - Mirror: Off 05:36:17 INFO - Online: Yes 05:36:17 INFO - Rotation: Supported 05:36:17 INFO - Return code: 0 05:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:17 INFO - Python 2.7.3 05:36:17 INFO - Return code: 0 05:36:17 INFO - grabbing minidump binary from tooltool 05:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100828d30>, '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 0x10058ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100820b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:36:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:36:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:36:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:17 INFO - Return code: 0 05:36:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:36:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:36:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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 05:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0301 --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 05:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CvTrPclooW/Render', 05:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:17 INFO - 'HOME': '/Users/cltbld', 05:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:17 INFO - 'LOGNAME': 'cltbld', 05:36:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:17 INFO - 'MOZ_NO_REMOTE': '1', 05:36:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:17 INFO - 'NO_EM_RESTART': '1', 05:36:17 INFO - 'PAGER': '/bin/cat', 05:36:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:17 INFO - 'PWD': '/builds/slave/test', 05:36:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:17 INFO - 'SHELL': '/bin/bash', 05:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mt709eSaFB/Listeners', 05:36:17 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 05:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:17 INFO - 'USER': 'cltbld', 05:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:17 INFO - 'XPC_FLAGS': '0x0', 05:36:17 INFO - 'XPC_SERVICE_NAME': '0', 05:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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 05:36:17 INFO - mozversion application_buildid: 20160831030224 05:36:17 INFO - mozversion application_changeset: 506facea63169a29e04eb140663da1730052db64 05:36:17 INFO - mozversion application_display_name: Nightly 05:36:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:17 INFO - mozversion application_name: Firefox 05:36:17 INFO - mozversion application_remotingname: firefox 05:36:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:36:17 INFO - mozversion application_vendor: Mozilla 05:36:17 INFO - mozversion application_version: 51.0a1 05:36:17 INFO - mozversion platform_buildid: 20160831030224 05:36:17 INFO - mozversion platform_changeset: 506facea63169a29e04eb140663da1730052db64 05:36:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:36:17 INFO - mozversion platform_version: 51.0a1 05:36:17 INFO - using testdate: 1472646977 05:36:17 INFO - actual date: 1472646977 05:36:17 INFO - starting webserver on 'localhost:49365' 05:36:17 INFO - SUITE-START | Running 2 tests 05:36:17 INFO - TEST-START | dromaeo_css 05:36:17 INFO - operating with platform_type : mac_ 05:36:17 INFO - Initialising browser for dromaeo_css test... 05:36:17 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpPG4jpB/profile http://localhost:49365/getInfo.html) 05:36:20 INFO - PROCESS | 1999 | __metrics Screen width/height:1600/1200 05:36:20 INFO - PROCESS | 1999 | colorDepth:24 05:36:20 INFO - PROCESS | 1999 | Browser inner width/height: 1024/663 05:36:20 INFO - PROCESS | 1999 | __metrics 05:36:21 ERROR - PROCESS | 1999 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:36:21 INFO - TEST-INFO | 1999: exit 0 05:36:21 INFO - Browser initialized. 05:36:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:21 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpPG4jpB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:33 INFO - PROCESS | 2005 | RSS: Main: 255201280 05:36:33 INFO - PROCESS | 2005 | 05:37:23 INFO - PROCESS | 2005 | 1472647043326 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:39:35 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49365/tests/dromaeo/cssquery-ext.html) 05:39:36 INFO - PROCESS | 2005 | RSS: Main: 277962752 05:39:36 INFO - PROCESS | 2005 | 05:42:39 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49365/tests/dromaeo/cssquery-ext.html (next: http://localhost:49365/tests/dromaeo/cssquery-jquery.html) 05:42:39 INFO - PROCESS | 2005 | RSS: Main: 287330304 05:42:39 INFO - PROCESS | 2005 | 05:45:41 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49365/tests/dromaeo/cssquery-mootools.html) 05:45:42 INFO - PROCESS | 2005 | RSS: Main: 287727616 05:45:42 INFO - PROCESS | 2005 | 05:48:44 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49365/tests/dromaeo/cssquery-prototype.html) 05:48:45 INFO - PROCESS | 2005 | RSS: Main: 283787264 05:48:45 INFO - PROCESS | 2005 | 05:51:47 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49365/tests/dromaeo/cssquery-yui.html) 05:51:48 INFO - PROCESS | 2005 | RSS: Main: 289292288 05:51:48 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49365/tests/dromaeo/cssquery-yui.html (next: http://localhost:49365/tests/dromaeo/cssquery-dojo.html) 05:54:51 INFO - PROCESS | 2005 | RSS: Main: 291942400 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | __start_tp_report 05:54:51 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 05:54:51 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 05:54:51 INFO - PROCESS | 2005 | |i|pagename|runs| 05:54:51 INFO - PROCESS | 2005 | |0;dojo.html;3380.104272367823;3392.626811050784;3413.8463769130385;3421.8289085545716;3435.793852368859;5103.183490641493;5164.380274367072;5683.119116536933;5707.971460142704;5756.453136951994;4745.762711864401;5130.589552835773;5336.265713643063;5705.971470142654;5766.942330576693;5203;5215.973920130394;5263.3683957925105;5344;5360.517553420192;5093.974530127344;5187.714675692835;5414.810481633143;5428.5385742211765;5434.972825135888;5140.691558506502;5284.947150528484;5290.55030322423;5295.391030031518;5321.760520776555;5164.354455693038;5186.5332120109;5201.08980928336;5206.869828254286;5249.396319423277;5151.407588127338;5167.199084141964;5225.741021067817;5233.816816411445;5308.495692909168;4594.816207351702;5654.943450565483;5694.889496548175;5779.595428320019;5786.826395208151;6159.568830181889;6177.536684748617;6252.906206406908;6268.87462250757;6272.937270627281;6185.845353866144;6230.844228894269;6253.624782513064;6262.060690896356;6289.842753931189;4502.459704835375;4974.129527332739;5685.658860468385;5807.070868660994;5946.732397042144;4850.902981940341;5148.794048238104;5437.374701909252;5715.228444160069;6283.748650054038;6149.723262453201;6172.660503672251;6173.753049878044;6176.258848938066;6184.721687524072;6101.217066730133;6190.50475961931;6199.690015499207;6255.874882502416;6277.497800175975;6057.939420605738;6170.876582468325;6220.595661282093;6244.313125556185;6255.874882502325;6200.193974783249;6205.875882482325;6297.27581328144;6312.147860038928;6313.2424109107205;3973.7218394712095;4842.394700662418;4968.826091086795;4969.552740253394;4970.229614409773;4374.21264172452;4424.137293227854;4451.354553589711;4507.233770259064;4517.435320584927;5171.224316352502;5875.030619947661;5875.941240587625;5888.322842873039;5891.3224979127945;6127.6782420562195;6285.685715714196;6291.496680265568;6293.056041593798;6295.496360291166;5743.483086522233;5803.622764520293;5853.765849366063;5887.646741195542;5955.225820643289;5419.3225846769155;5425.348958125051;5430.83707488776;5436.075867102602;5438.3473983121485;6230.532710046855;6351.904721429182;6356.586821856565;6366.9681651591445;6371.362863713592;6216.440520353009;6223;6246.843828904313;6258.687065646791;6311.211098612674;6317.305096439296;6329.303776584664;6336.7148478319505;6338.461230795434;6349.49204063683;6014.0678194879865;6151.96924015395;6235.3452887446165;6255.53083518747;6270.467010304175;6174.413430724074;6201.596896201732;6246.937530624636;6270.184875966095;6281.371862813682;4860.441049279378;5884.6469211847425;6141.385861413823;6157.353477884937;6166.383361663798;5349.090654588807;5963.612365196248;6106.45041946227;6170.722317495633;6196.349383314687;5797.4782269595935;5893.852653683693;5922.170896074639;6031.939680603314;6051.818445446644;6101.359357267423;6112.991356426318;6117;6125.601835880653;6144.139820425234;5828.6502809831545;5942.702864856827;5983.1025346196675;5999.1901093351835;6006.969965150146 05:54:51 INFO - PROCESS | 2005 | |1;ext.html;508.7583397886002;513.8105286262302;527.5252272954341;539.4767075936343;562.0529407947606;28821.85589072057;37242.255154896884;37593.62406375935;37649.30578123988;39814.60185398149;33414.164645883866;36826.4476032859;40948;40978.385324220086;41085;9600.135987761118;9819.754506137333;9828;9839.163671087967;9877.160441362494;9630;9635.614575416976;9757.121859032686;9760.219182465422;9765.853512197322;8273;8455.788605284886;9737.95131024344;9756.170725488342;9767.97436269192;9680.709578712649;9727.27045471589;9760.4631745254;9767.755806104904;9781;9748.220142388593;9814.362066465657;9853.408795472295;9857;9863.753406164831;39032.219355613015;39197.60802391968;39248;39302.60697393018;39465.21069578621;3326.850291736878;3360.277540328841;3534.5228394166716;3563.768355056913;3712;30065.849670751726;30255.94104206364;30449.695503044906;30593.694063059305;31424.37151256985;3211.341674956628;3251.252211991255;3266.7549933755063;3305.7024867761775;3388.508666243381;459121;460143;464253;466178;468289;55373.446265537634;55711;55962.72018639962;56089.158662620095;56113.43886561082;28898.133056008355;32862.67137328644;34337.65662343395;58128;58226.4177358221;16154.353825846834;16239;16295.429659961845;16440;16511.00933943967;12624.55814046504;12694.873051269555;12709.745805084032;12715.364231788373;12721.427535760913;17868.9106554469;18452.35416760407;18471.445856624323;18474.630507390048;18490.075496225403;6736.126727131918;7880.911558437018;7928.246816552418;8023.83952320962;8062.919370806334;827.3629305434781;967.888692800337;975.5463709375033;993.2554270400693;1014.1531820929606;24741.752582473946;28855.278618034718;29348.119556412916;29590.852045739633;30357.089287321414;879.6877108626345;914.9130832570895;1037.159900480613;1065.9786804263872;1131.7623299107279;15238.771418428732;15257.6185595361;15424.845751542342;15446;15831.683366332609;656297.7185114044;658733;659174.4082559209;662767;663046;55341;55665;55764;55806;55867.441325586224;1346.7037251804588;1376.566381589796;1396.8882489400823;1401.6355747505518;1404.1294397473632;23695;25975.740242598087;28484.287892802844;29551.41952997289;29622.407551849272;43158;44280.7785961081;47438.52561474341;47921;47956.5204347952;552427;553804;554227;560894;564963;25517.48965020652;25557.105501307364;25710.68603825665;26037;26047;35668.46497302595;41957;46117.53882461267;46355.76822115868;46639;32056.83971580127;33140;38533.4219986706;39356.606433935296;39446.01384965399;29947.850260748557;37587.81206093952;38264;38819;39719;31327;37138;37142.628573714996;37221.25557488889;37507.81246093752;30059.849700751358;31625.418729063917;33180.83409582936;33741;34954.65045349616;21524.476359078977;23291.373160723473;24280.907359168526;24524.75475245225;25327.87336063308 05:54:51 INFO - PROCESS | 2005 | |2;jquery.html;355.8309802843649;375.92857357102133;382.89853188904925;389.68435567190596;405.8964963934196;18435.44693659189;19268.518287042814;20035.39893803188;20961.68557471639;21192.894035529822;20235;20396.286129985452;21058.052387642554;21359.893200534014;21361.893190534025;5932.525397968152;5969.432903874136;6091;6141.508679305645;6155.476784473325;4258.084511829956;6083.969580152093;6130.938690613081;6134;6431.29255781866;6644.335566443341;6787.728490860384;6791.694373753168;6796.660166991655;6798.18421789386;5572.108462645978;5905.793297234576;5919.230500034968;5980.790672326491;6773.593584384928;5664.178694089334;5685;5738.512226460756;5739.540836733051;5747.224124743189;13131.803022954664;13213.86786132136;13316.134451260734;21711.697298162002;25133.37166570832;2253.785890340415;2296.0700916128994;2309.561183375153;2471.283327834926;2800.7339302766204;9748.073932976356;9924.45415502147;10132.138768204712;10188.490575471196;13397.933010334886;1692.4161164398263;1739.2684753868266;1765.3291749135374;1795.7485951966605;1807.9819201808077;117339.4133029338;120642;121633;123907.76092239052;125763;11200.10399168081;11509.309441433541;11539.076873850072;11622.07023438123;11775.470103845348;14343.85656143446;14382.712345753027;14482.131072135706;14494.710105797825;14522.273886305642;8486.702965396305;8567.228949394585;8619.051904290523;8664.003639581402;8757.2994160467;8402.369822263354;8443.197896199852;8498.362622803315;8623.626565192744;8754.86867696985;3695.334839728821;4463.509014008457;4467.195904737178;4486.775661216926;4571.062932098912;1561.5705680937833;1654.1481137214344;1895.8388536974235;1901.6196760647927;1923.9326623568109;726.8769750735127;816.3428440105653;900.5092224737534;919.1543779722671;992.8758905136858;20276.479264055255;20808.342114594256;21993.780062199494;22038.11847526081;22067.779322206574;833.329170018129;851.4082712514867;868.8783570300163;912.6942474271193;945.808281565219;7897.775844744074;7998.84002319962;9960.900390995997;11042.668719938414;11073.446327683745;411648;414642;415128;415195;416041;127346.36326818306;130828.3458582701;133719.33140334237;135609.96585051232;144263;852.4203541591777;879.8957308577694;883.4081165619051;884.7436639971256;960.13108137136;17263.741043884602;19151.904240478707;19602.019899004707;19684.90157549203;19806.702899456806;53594.51635643671;54498.45501545093;55052.17421738597;55258.72370638121;55478;77341.61329193543;77968.28696647266;78708.60645696735;78921.60539197497;79825;7831.843363132592;8032.959835200787;8043.0750463695085;8121.9593902032475;8245.381596380175;11177.88822111801;12310.446029928853;12632.2420654761;12638.747225055631;12754.107212495037;7961.6019199040975;9452.243820494481;10171.593136274467;10617;11001.00990910822;9425.821772278465;10279.383237005804;10622.628208012682;10704.090152336827;10899.618513351994;11087.22389432732;11118.944405277922;11336.94331528337;11348.978591926767;11359.716007099889;7219.891701624375;7343.412526997934;8062.717804876801;8146.67413303485;8182.345412366877;9261.212796912068;10855.782884342427;10966.835497467704;11115.888841111486;11244.887551124712 05:54:51 INFO - PROCESS | 2005 | |3;mootools.html;1522.0791421190177;1540.6918616276744;1767.1959258537358;1859.0425930645729;1887.5182981359635;7998.520088794662;8514.574271286441;8722.781930451742;9122.817543649124;9132.452052876832;8731.869021964676;8869.29045676346;8932.59803308851;8934.821303573925;8942.91057089429;2355.364051706034;2388.4267775733874;2392.688950436441;2399.3281881073326;2401.5797235483806;2351.729551101628;2379.0364902214546;2387.77316154965;2395.3532546212514;2401.2076014915037;2373.8100951923893;2383.5828729972272;2389.976100238993;2395.3053614451874;2403.4231784371714;1945.6984167454068;2328.860268383894;2353.7410884802657;2363.3500787283465;2377.322463098026;2308.1734157988244;2308.734495533002;2326.255308518611;2329.9301020969397;2331.25399872041;7559.470837041409;8932.732018039469;8949.910500894974;8967.596458159398;8969.730908072768;4404.471463424377;4572.428446444194;5355.089634762061;5426.8914621707345;5433.239346491494;3354.8258109661665;3495.94756078659;3695.907602309937;3776.4712940188397;3790.507234059582;1095.2059756676426;1104.690686607751;1119.6193294279983;1119.8936101070385;1128.424503503211;9621;9635.373700709431;11641.767164656743;11650.41747912601;11746.765064698744;4711.52884711533;4755.738434386073;4805.511215659895;4870.196417591058;4906.067847109038;10023.2482563808;10116.747081323027;10118.747031324128;10119.494025298853;10126.240531960133;5417.160340147283;5433.456654334614;5437.211604317431;5443;5453.890922181534;4224.725392849455;4428.911421771547;4694;4884.462709101996;4933.580645645088;3260.543523906655;3925.764454132704;4038.7172897897453;4083.8570650027104;4089.3252613319064;1162.5582278734028;1268.207370393504;1336.2717319061135;1338.6586420462913;1345.4618152738788;642.2934771751037;784.2197013971021;799.2127754162145;901.715959472764;907.3285768531372;5902.586818922634;5951.107333899863;6103.115048317969;6130.846728831815;6298.086777417248;915.1214833759532;920.6615197398532;962.2830990911815;971.7764914069803;1017.399734156851;3889.105505733697;4018.578049304839;4105.651019663303;4132.938005929914;4161.167766446722;10292.639757608447;10690.251682382159;10709.946450267698;10742.516586753614;10770.78458430827;10621.893781062245;10676.733081673021;10698.144148468104;10698.679039628823;10710.678679639623;6785.796426107225;7967.322777563856;8110.188981101843;8195.42632015765;8203;5776.162456443876;5846.444587764156;5917.881642367214;5945.108233764797;5953.851153721192;9901.158401535662;10014.198864091;10015.298929075187;10053.346532475365;10104.989501049837;9584.520773961414;9888.50557472138;10071.446070466194;10075.294729368874;10179.694609161737;6909.723611055501;7346.742863999734;7381.926180738124;7582.165961744094;7597.772066838003;8343.54110523927;8440.366972476966;8447.02859171203;8447.619857106321;8485.95757021211;7321.78034658961;7443.702251910079;7459.664315105942;7503.024606801299;7576.545407275581;7352.5220860643885;7422.517536360119;7438.739644112647;7496.4002879768395;7563.054618172729;6884.690188941409;7019.4735394844565;7027.543209691354;7028.894566581607;7035.929640703527;4981.1283025469675;5056.82301119459;5111.284420181252;5149.716765577929;5158.767855446439;4015.357542793139;5093.6179786516905;5187.792488300577;5271.65734227274;5282.418933917343 05:54:51 INFO - PROCESS | 2005 | |4;prototype.html;309.4321919278124;315.55821849410825;316.5204714856991;321.7988757026859;322.3729845450598;4671.696339737915;4822.4454187768415;5073.923891141631;5321.441248668887;5636.323641163061;4321.848735294266;4672.602828759551;5506.944930550693;5513.754409104987;5609.551235901128;4043.555208927016;4120.299549076664;4133.276676581601;4159.334506478964;4222.514410842762;3438.6905178533925;3644.872429464969;3837.366834472323;4207.179599978005;4253.362455454641;4193.888619515831;4215.5784421557755;4217.641500472449;4239.915201695964;4279.379489973952;3309.470484722457;3793.2603142387247;4129.442525259096;4254.595813397737;4261.957380426218;2982.567527708492;3168.651448340681;3593.802340871251;3637.654422829827;3660.103274697716;5046.7224302663335;5341.786328546854;5367.46325367464;5394.568434525228;5423.023855705971;4429.224885645;4630.398048253739;4670.346151538787;4774.904501909942;4865.537773911473;4416.823327066913;5097.617678674114;5837.50381217597;5868.2371291732225;5902.527797776168;3368.96631033689;4029.738067025634;4054.290499162664;4055.7566546007333;4092.3656833190903;4960.553550180501;6100.176476175659;6161.260648722137;6173.444390004876;6184.381561843779;4099.528554216244;4136.793160341971;4174.415581818548;4176.2691528982305;4201.264778663722;4237.855778939731;4238.054552086271;4246;4260.403543503912;4307.698461107692;3763.41667041609;4476.462824461086;4705.317728929286;4923.59677491913;4960.528749768766;4941.985388912761;5616.001758434996;5884.558658100659;5939.613925094855;5945.851353716105;1110.838928355384;1440.7262620102147;1453.542134227715;1454.0984589554544;1462.3638717158071;769.5728870476827;835.8620827563506;847.9951257759575;853.7918844834613;877.4954401219197;4259.850905218303;4472.993576445274;4487.887802804956;4840.564349208588;5507.449255074541;5357.303550538483;5454.990826697073;6043.791241751667;6061.333253342129;6101.542384321194;5145.614078944094;5187.403448603383;5506.2841830562575;5540.69793598504;5544.805931792368;2713.71505991872;2724.50958827413;3138.5449109879396;3144.0349781386635;3200.6159260888844;5637.013522633522;5911.704414779244;6115.357887421846;6216.844578885473;6284.591501552384;5409.350877894599;5914.4381283777975;5948.226730525004;6082.026875699955;6130.846728831815;5030.773615187252;5475.835724928259;6041.818745437644;6148.354422785543;6168.506519478431;5329.49369809883;5678.630888992202;5996.340402555803;6017.669028203491;6034.788782392595;4951.628627852853;5585.31904685745;5897.351291358033;5964.135200395832;6030.90953635687;4661.976690116528;5545.146123444168;5755.769769209185;5991.071383935497;6174.289956655042;3924.293627147141;3933.5642490491337;4102.548719640897;4111.383292506148;4133.669306455537;5215.55667768244;5263.9210411844615;5690.687012214203;5979.910301345396;5983.431574000463;4636.65225108125;5039.244113383022;5109.6750978304035;5438.945610543844;5722.284714410699;5212.98346822366;5492.752826122754;5553.805616803393;5879.176915231786;5889.411058894077;4795.328653988375;4833.694902376409;5029.572486338702;5532.640378375393;5823.475887170175;5288.497592728685;5460.907818436249;5638.956792993309;5727.079189613411;5763.366029736641;4816.903661926812;5367.329083864517;5685.744141513559;5706.629069110494;5761.510271626791 05:54:51 INFO - PROCESS | 2005 | |5;yui.html;707.6603230449384;716.6560051175436;735.1362149474367;766.9233076692328;777.1179711027984;15315.617109572253;16331.755023674654;16390.83609163908;16487.422940197095;16507.587310317234;14657;14743.705125897503;14760.114393136393;14765.926170369134;14828.110313381178;683.6240067962625;836.2139588786551;842.4608250719529;854.3848429131046;866.5450638414819;828.5484410995991;845.7293666026874;846.7459762071354;847.2755793796308;850.1158794853345;886.330820230725;895.042304733935;904.5160838951163;907.8184363127368;908.6274627402767;876.430320291809;902.4179404284233;903.584351198443;904.0642934562761;904.4347282948157;670.0351493848842;673.5857447669697;673.6800019990515;676.0130209893562;679.3478260869522;5883.23517942669;5926.911096333559;7069.081019467488;14929.701405971928;15148.924255378763;12921.67695807603;14802.925985370111;14807.111573305636;14908.329125189284;15015.699686006328;11946.88053119475;12005.819912701316;12043;12044.096692748079;12126.05459057072;3843.3658446356317;3875.283072631544;3876.1472476055224;3896.2012787378803;4034.245103380039;103583;114893.4255328718;117835;119676.40161799222;125080.74919250872;11281.21031527785;11340.94329528347;11390.088792896548;11452.370119643332;11550.249233799776;20197.596048078954;24044.87977560136;24049.639255411184;24090.759092409204;24094.39764005879;8074.192580741878;8269.751907442786;8295.253427191581;8359.331253499706;8426.368022398345;3886.8639597613947;4433.911321773611;4526.049529598756;4565.657575681837;4606;2815.8595768713703;2886.278430392402;2916.5916771651987;3338.4825352070466;3619.728520360931;642.4410762636536;657.5167252069725;665.1087542692815;678.3860606151441;688.1948120698794;601.4122716029685;618.245740196968;624.8000639795222;644.2301449767483;658.7793089315134;7762.961185194151;8376.120507346763;8771.91228087711;9304.441733496013;9547.52262386878;560.4731552340787;644.8065580325883;647.0552992630718;666.5868359078784;668.6706945643216;4375.365571992043;4526.864194074183;4548.909021819545;4739.392917202013;4765.761711914391;103359;164873;166152.16923915304;171481.14259428624;171951.14024429797;149614;150110;150456.49543504426;152389;152627.23686381496;91064;94777;107238.9276107229;119048;121414.3929280348;7132.322429369202;8983.910160898307;9014;9030.548472576476;9075.319351048565;67890;69028.3097169022;69221.30778692149;69370;70484.29515704777;87920;96903;105827;106440.46779766052;107748;11727.413629318671;11790.587329443428;12052.698682533006;12097.57658481949;12485.812712809497;13220.405081771536;13431.798523021967;13724.245166515539;13857.653558660711;13915.98983506885;11821.113416493625;12471.376431178587;12621.242725436136;12676.112672112864;13196.88467636487;13737.725245495234;13882.51411200603;13980.860191397956;14184.219867906952;14454.494092706705;13746.587602371945;13778.311084445537;14196.515609768456;14218.857811421753;14459.13245205291;11399.601013964471;11511.194216405107;11526.464177880853;11755.177137600285;11932.880671193177;8463.49219046859;9773.966407300104;10240.64157754475;11541.941385533008;11674.474648640662 05:54:51 INFO - PROCESS | 2005 | __end_tp_report 05:54:51 INFO - PROCESS | 2005 | __start_cc_report 05:54:51 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,386 05:54:51 INFO - PROCESS | 2005 | __end_cc_report 05:54:51 INFO - PROCESS | 2005 | __startTimestamp1472648091485__endTimestamp 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | ------- Summary: start ------- 05:54:51 INFO - PROCESS | 2005 | Number of tests: 6 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | [#0] dojo.html Cycles:165 Average:5691.20 Median:5893.85 stddev:670.80 (11.4%) stddev-sans-first:647.90 05:54:51 INFO - PROCESS | 2005 | Values: 3380.1 3392.6 3413.8 3421.8 3435.8 5103.2 5164.4 5683.1 5708.0 5756.5 4745.8 5130.6 5336.3 5706.0 5766.9 5203.0 5216.0 5263.4 5344.0 5360.5 5094.0 5187.7 5414.8 5428.5 5435.0 5140.7 5284.9 5290.6 5295.4 5321.8 5164.4 5186.5 5201.1 5206.9 5249.4 5151.4 5167.2 5225.7 5233.8 5308.5 4594.8 5654.9 5694.9 5779.6 5786.8 6159.6 6177.5 6252.9 6268.9 6272.9 6185.8 6230.8 6253.6 6262.1 6289.8 4502.5 4974.1 5685.7 5807.1 5946.7 4850.9 5148.8 5437.4 5715.2 6283.7 6149.7 6172.7 6173.8 6176.3 6184.7 6101.2 6190.5 6199.7 6255.9 6277.5 6057.9 6170.9 6220.6 6244.3 6255.9 6200.2 6205.9 6297.3 6312.1 6313.2 3973.7 4842.4 4968.8 4969.6 4970.2 4374.2 4424.1 4451.4 4507.2 4517.4 5171.2 5875.0 5875.9 5888.3 5891.3 6127.7 6285.7 6291.5 6293.1 6295.5 5743.5 5803.6 5853.8 5887.6 5955.2 5419.3 5425.3 5430.8 5436.1 5438.3 6230.5 6351.9 6356.6 6367.0 6371.4 6216.4 6223.0 6246.8 6258.7 6311.2 6317.3 6329.3 6336.7 6338.5 6349.5 6014.1 6152.0 6235.3 6255.5 6270.5 6174.4 6201.6 6246.9 6270.2 6281.4 4860.4 5884.6 6141.4 6157.4 6166.4 5349.1 5963.6 6106.5 6170.7 6196.3 5797.5 5893.9 5922.2 6031.9 6051.8 6101.4 6113.0 6117.0 6125.6 6144.1 5828.7 5942.7 5983.1 5999.2 6007.0 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | [#1] ext.html Cycles:180 Average:67952.96 Median:38925.61 stddev:151516.48 (389.2%) stddev-sans-first:151856.91 05:54:51 INFO - PROCESS | 2005 | Values: 508.8 513.8 527.5 539.5 562.1 28821.9 37242.3 37593.6 37649.3 39814.6 33414.2 36826.4 40948.0 40978.4 41085.0 9600.1 9819.8 9828.0 9839.2 9877.2 9630.0 9635.6 9757.1 9760.2 9765.9 8273.0 8455.8 9738.0 9756.2 9768.0 9680.7 9727.3 9760.5 9767.8 9781.0 9748.2 9814.4 9853.4 9857.0 9863.8 39032.2 39197.6 39248.0 39302.6 39465.2 3326.9 3360.3 3534.5 3563.8 3712.0 30065.8 30255.9 30449.7 30593.7 31424.4 3211.3 3251.3 3266.8 3305.7 3388.5 459121.0 460143.0 464253.0 466178.0 468289.0 55373.4 55711.0 55962.7 56089.2 56113.4 28898.1 32862.7 34337.7 58128.0 58226.4 16154.4 16239.0 16295.4 16440.0 16511.0 12624.6 12694.9 12709.7 12715.4 12721.4 17868.9 18452.4 18471.4 18474.6 18490.1 6736.1 7880.9 7928.2 8023.8 8062.9 827.4 967.9 975.5 993.3 1014.2 24741.8 28855.3 29348.1 29590.9 30357.1 879.7 914.9 1037.2 1066.0 1131.8 15238.8 15257.6 15424.8 15446.0 15831.7 656297.7 658733.0 659174.4 662767.0 663046.0 55341.0 55665.0 55764.0 55806.0 55867.4 1346.7 1376.6 1396.9 1401.6 1404.1 23695.0 25975.7 28484.3 29551.4 29622.4 43158.0 44280.8 47438.5 47921.0 47956.5 552427.0 553804.0 554227.0 560894.0 564963.0 25517.5 25557.1 25710.7 26037.0 26047.0 35668.5 41957.0 46117.5 46355.8 46639.0 32056.8 33140.0 38533.4 39356.6 39446.0 29947.9 37587.8 38264.0 38819.0 39719.0 31327.0 37138.0 37142.6 37221.3 37507.8 30059.8 31625.4 33180.8 33741.0 34954.7 21524.5 23291.4 24280.9 24524.8 25327.9 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | [#2] jquery.html Cycles:180 Average:30005.84 Median:397.79 stddev:71918.95 (18079.6%) stddev-sans-first:72086.24 05:54:51 INFO - PROCESS | 2005 | Values: 355.8 375.9 382.9 389.7 405.9 18435.4 19268.5 20035.4 20961.7 21192.9 20235.0 20396.3 21058.1 21359.9 21361.9 5932.5 5969.4 6091.0 6141.5 6155.5 4258.1 6084.0 6130.9 6134.0 6431.3 6644.3 6787.7 6791.7 6796.7 6798.2 5572.1 5905.8 5919.2 5980.8 6773.6 5664.2 5685.0 5738.5 5739.5 5747.2 13131.8 13213.9 13316.1 21711.7 25133.4 2253.8 2296.1 2309.6 2471.3 2800.7 9748.1 9924.5 10132.1 10188.5 13397.9 1692.4 1739.3 1765.3 1795.7 1808.0 117339.4 120642.0 121633.0 123907.8 125763.0 11200.1 11509.3 11539.1 11622.1 11775.5 14343.9 14382.7 14482.1 14494.7 14522.3 8486.7 8567.2 8619.1 8664.0 8757.3 8402.4 8443.2 8498.4 8623.6 8754.9 3695.3 4463.5 4467.2 4486.8 4571.1 1561.6 1654.1 1895.8 1901.6 1923.9 726.9 816.3 900.5 919.2 992.9 20276.5 20808.3 21993.8 22038.1 22067.8 833.3 851.4 868.9 912.7 945.8 7897.8 7998.8 9960.9 11042.7 11073.4 411648.0 414642.0 415128.0 415195.0 416041.0 127346.4 130828.3 133719.3 135610.0 144263.0 852.4 879.9 883.4 884.7 960.1 17263.7 19151.9 19602.0 19684.9 19806.7 53594.5 54498.5 55052.2 55258.7 55478.0 77341.6 77968.3 78708.6 78921.6 79825.0 7831.8 8033.0 8043.1 8122.0 8245.4 11177.9 12310.4 12632.2 12638.7 12754.1 7961.6 9452.2 10171.6 10617.0 11001.0 9425.8 10279.4 10622.6 10704.1 10899.6 11087.2 11118.9 11336.9 11349.0 11359.7 7219.9 7343.4 8062.7 8146.7 8182.3 9261.2 10855.8 10966.8 11115.9 11244.9 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | [#3] mootools.html Cycles:180 Average:5700.75 Median:4877.33 stddev:3162.90 (64.8%) stddev-sans-first:3156.19 05:54:51 INFO - PROCESS | 2005 | Values: 1522.1 1540.7 1767.2 1859.0 1887.5 7998.5 8514.6 8722.8 9122.8 9132.5 8731.9 8869.3 8932.6 8934.8 8942.9 2355.4 2388.4 2392.7 2399.3 2401.6 2351.7 2379.0 2387.8 2395.4 2401.2 2373.8 2383.6 2390.0 2395.3 2403.4 1945.7 2328.9 2353.7 2363.4 2377.3 2308.2 2308.7 2326.3 2329.9 2331.3 7559.5 8932.7 8949.9 8967.6 8969.7 4404.5 4572.4 5355.1 5426.9 5433.2 3354.8 3495.9 3695.9 3776.5 3790.5 1095.2 1104.7 1119.6 1119.9 1128.4 9621.0 9635.4 11641.8 11650.4 11746.8 4711.5 4755.7 4805.5 4870.2 4906.1 10023.2 10116.7 10118.7 10119.5 10126.2 5417.2 5433.5 5437.2 5443.0 5453.9 4224.7 4428.9 4694.0 4884.5 4933.6 3260.5 3925.8 4038.7 4083.9 4089.3 1162.6 1268.2 1336.3 1338.7 1345.5 642.3 784.2 799.2 901.7 907.3 5902.6 5951.1 6103.1 6130.8 6298.1 915.1 920.7 962.3 971.8 1017.4 3889.1 4018.6 4105.7 4132.9 4161.2 10292.6 10690.3 10709.9 10742.5 10770.8 10621.9 10676.7 10698.1 10698.7 10710.7 6785.8 7967.3 8110.2 8195.4 8203.0 5776.2 5846.4 5917.9 5945.1 5953.9 9901.2 10014.2 10015.3 10053.3 10105.0 9584.5 9888.5 10071.4 10075.3 10179.7 6909.7 7346.7 7381.9 7582.2 7597.8 8343.5 8440.4 8447.0 8447.6 8486.0 7321.8 7443.7 7459.7 7503.0 7576.5 7352.5 7422.5 7438.7 7496.4 7563.1 6884.7 7019.5 7027.5 7028.9 7035.9 4981.1 5056.8 5111.3 5149.7 5158.8 4015.4 5093.6 5187.8 5271.7 5282.4 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | [#4] prototype.html Cycles:180 Average:4630.19 Median:5060.32 stddev:1426.06 (28.2%) stddev-sans-first:1392.70 05:54:51 INFO - PROCESS | 2005 | Values: 309.4 315.6 316.5 321.8 322.4 4671.7 4822.4 5073.9 5321.4 5636.3 4321.8 4672.6 5506.9 5513.8 5609.6 4043.6 4120.3 4133.3 4159.3 4222.5 3438.7 3644.9 3837.4 4207.2 4253.4 4193.9 4215.6 4217.6 4239.9 4279.4 3309.5 3793.3 4129.4 4254.6 4262.0 2982.6 3168.7 3593.8 3637.7 3660.1 5046.7 5341.8 5367.5 5394.6 5423.0 4429.2 4630.4 4670.3 4774.9 4865.5 4416.8 5097.6 5837.5 5868.2 5902.5 3369.0 4029.7 4054.3 4055.8 4092.4 4960.6 6100.2 6161.3 6173.4 6184.4 4099.5 4136.8 4174.4 4176.3 4201.3 4237.9 4238.1 4246.0 4260.4 4307.7 3763.4 4476.5 4705.3 4923.6 4960.5 4942.0 5616.0 5884.6 5939.6 5945.9 1110.8 1440.7 1453.5 1454.1 1462.4 769.6 835.9 848.0 853.8 877.5 4259.9 4473.0 4487.9 4840.6 5507.4 5357.3 5455.0 6043.8 6061.3 6101.5 5145.6 5187.4 5506.3 5540.7 5544.8 2713.7 2724.5 3138.5 3144.0 3200.6 5637.0 5911.7 6115.4 6216.8 6284.6 5409.4 5914.4 5948.2 6082.0 6130.8 5030.8 5475.8 6041.8 6148.4 6168.5 5329.5 5678.6 5996.3 6017.7 6034.8 4951.6 5585.3 5897.4 5964.1 6030.9 4662.0 5545.1 5755.8 5991.1 6174.3 3924.3 3933.6 4102.5 4111.4 4133.7 5215.6 5263.9 5690.7 5979.9 5983.4 4636.7 5039.2 5109.7 5438.9 5722.3 5213.0 5492.8 5553.8 5879.2 5889.4 4795.3 4833.7 5029.6 5532.6 5823.5 5288.5 5460.9 5639.0 5727.1 5763.4 4816.9 5367.3 5685.7 5706.6 5761.5 05:54:51 INFO - PROCESS | 2005 | 05:54:51 INFO - PROCESS | 2005 | [#5] yui.html Cycles:180 Average:26068.92 Median:3731.55 stddev:43072.86 (1154.3%) stddev-sans-first:43151.60 05:54:51 INFO - PROCESS | 2005 | Values: 707.7 716.7 735.1 766.9 777.1 15315.6 16331.8 16390.8 16487.4 16507.6 14657.0 14743.7 14760.1 14765.9 14828.1 683.6 836.2 842.5 854.4 866.5 828.5 845.7 846.7 847.3 850.1 886.3 895.0 904.5 907.8 908.6 876.4 902.4 903.6 904.1 904.4 670.0 673.6 673.7 676.0 679.3 5883.2 5926.9 7069.1 14929.7 15148.9 12921.7 14802.9 14807.1 14908.3 15015.7 11946.9 12005.8 12043.0 12044.1 12126.1 3843.4 3875.3 3876.1 3896.2 4034.2 103583.0 114893.4 117835.0 119676.4 125080.7 11281.2 11340.9 11390.1 11452.4 11550.2 20197.6 24044.9 24049.6 24090.8 24094.4 8074.2 8269.8 8295.3 8359.3 8426.4 3886.9 4433.9 4526.0 4565.7 4606.0 2815.9 2886.3 2916.6 3338.5 3619.7 642.4 657.5 665.1 678.4 688.2 601.4 618.2 624.8 644.2 658.8 7763.0 8376.1 8771.9 9304.4 9547.5 560.5 644.8 647.1 666.6 668.7 4375.4 4526.9 4548.9 4739.4 4765.8 103359.0 164873.0 166152.2 171481.1 171951.1 149614.0 150110.0 150456.5 152389.0 152627.2 91064.0 94777.0 107238.9 119048.0 121414.4 7132.3 8983.9 9014.0 9030.5 9075.3 67890.0 69028.3 69221.3 69370.0 70484.3 87920.0 96903.0 105827.0 106440.5 107748.0 11727.4 11790.6 12052.7 12097.6 12485.8 13220.4 13431.8 13724.2 13857.7 13916.0 11821.1 12471.4 12621.2 12676.1 13196.9 13737.7 13882.5 13980.9 14184.2 14454.5 13746.6 13778.3 14196.5 14218.9 14459.1 11399.6 11511.2 11526.5 11755.2 11932.9 8463.5 9774.0 10240.6 11541.9 11674.5 05:54:51 INFO - PROCESS | 2005 | -------- Summary: end -------- 05:54:51 INFO - PROCESS | 2005 | 05:54:52 INFO - TEST-INFO | 2005: exit 0 05:54:52 INFO - TEST-OK | dromaeo_css | took 1114885ms 05:54:52 INFO - TEST-START | kraken 05:54:52 INFO - operating with platform_type : mac_ 05:54:52 INFO - Initialising browser for kraken test... 05:54:52 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpsSL8px/profile http://localhost:49365/getInfo.html) 05:54:54 INFO - PROCESS | 2010 | __metrics Screen width/height:1600/1200 05:54:54 INFO - PROCESS | 2010 | colorDepth:24 05:54:54 INFO - PROCESS | 2010 | Browser inner width/height: 1024/663 05:54:54 INFO - PROCESS | 2010 | __metrics 05:54:55 ERROR - PROCESS | 2010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:54:55 INFO - TEST-INFO | 2010: exit 0 05:54:55 INFO - Browser initialized. 05:54:55 INFO - Running cycle 1/1 for kraken test... 05:54:55 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpsSL8px/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:07 INFO - PROCESS | 2013 | RSS: Main: 258555904 05:55:07 INFO - PROCESS | 2013 | 05:55:10 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49365/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:11 INFO - PROCESS | 2013 | RSS: Main: 269119488 05:55:11 INFO - PROCESS | 2013 | 05:55:14 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49365/tests/kraken/driver.html?testName=audio-dft) 05:55:14 INFO - PROCESS | 2013 | RSS: Main: 277741568 05:55:14 INFO - PROCESS | 2013 | 05:55:18 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49365/tests/kraken/driver.html?testName=audio-fft) 05:55:18 INFO - PROCESS | 2013 | RSS: Main: 273498112 05:55:18 INFO - PROCESS | 2013 | 05:55:20 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49365/tests/kraken/driver.html?testName=audio-oscillator) 05:55:21 INFO - PROCESS | 2013 | RSS: Main: 274399232 05:55:21 INFO - PROCESS | 2013 | 05:55:23 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:24 INFO - PROCESS | 2013 | RSS: Main: 275283968 05:55:24 INFO - PROCESS | 2013 | 05:55:27 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49365/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:27 INFO - PROCESS | 2013 | RSS: Main: 274837504 05:55:27 INFO - PROCESS | 2013 | 05:55:30 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49365/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:31 INFO - PROCESS | 2013 | RSS: Main: 275116032 05:55:31 INFO - PROCESS | 2013 | 05:55:34 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49365/tests/kraken/driver.html?testName=json-parse-financial) 05:55:35 INFO - PROCESS | 2013 | RSS: Main: 275341312 05:55:35 INFO - PROCESS | 2013 | 05:55:36 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:37 INFO - PROCESS | 2013 | RSS: Main: 275435520 05:55:37 INFO - PROCESS | 2013 | 05:55:39 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:39 INFO - PROCESS | 2013 | RSS: Main: 275017728 05:55:39 INFO - PROCESS | 2013 | 05:55:42 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:42 INFO - PROCESS | 2013 | RSS: Main: 275795968 05:55:42 INFO - PROCESS | 2013 | 05:55:45 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:46 INFO - PROCESS | 2013 | RSS: Main: 275427328 05:55:46 INFO - PROCESS | 2013 | 05:55:49 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:50 INFO - PROCESS | 2013 | RSS: Main: 275992576 05:55:50 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49365/tests/kraken/driver.html?testName=ai-astar) 05:55:52 INFO - PROCESS | 2013 | RSS: Main: 277479424 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | __start_tp_report 05:55:52 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 05:55:52 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 05:55:52 INFO - PROCESS | 2013 | |i|pagename|runs| 05:55:52 INFO - PROCESS | 2013 | |0;ai-astar;156;101;169;168;173;115;116;116;117;137 05:55:52 INFO - PROCESS | 2013 | |1;audio-beat-detection;173;142;134;159;136;160;127;114;154;110 05:55:52 INFO - PROCESS | 2013 | |2;audio-dft;201;232;201;196;202;197;195;183;192;191 05:55:52 INFO - PROCESS | 2013 | |3;audio-fft;71;81;75;146;57;62;74;89;135;56 05:55:52 INFO - PROCESS | 2013 | |4;audio-oscillator;69;72;119;72;71;89;111;68;76;113 05:55:52 INFO - PROCESS | 2013 | |5;imaging-gaussian-blur;89;88;89;121;106;85;88;86;106;130 05:55:52 INFO - PROCESS | 2013 | |6;imaging-darkroom;111;93;88;155;153;149;96;98;95;97 05:55:52 INFO - PROCESS | 2013 | |7;imaging-desaturate;128;121;87;149;148;89;91;92;91;88 05:55:52 INFO - PROCESS | 2013 | |8;json-parse-financial;55;57;59;58;58;59;59;57;57;56 05:55:52 INFO - PROCESS | 2013 | |9;json-stringify-tinderbox;67;69;70;74;70;90;100;89;73;72 05:55:52 INFO - PROCESS | 2013 | |10;stanford-crypto-aes;112;108;85;88;87;87;81;106;108;110 05:55:52 INFO - PROCESS | 2013 | |11;stanford-crypto-ccm;156;158;150;138;140;166;133;145;188;156 05:55:52 INFO - PROCESS | 2013 | |12;stanford-crypto-pbkdf2;236;176;170;172;176;173;174;172;196;242 05:55:52 INFO - PROCESS | 2013 | |13;stanford-crypto-sha256-iterative;67;70;70;64;65;79;79;90;93;90 05:55:52 INFO - PROCESS | 2013 | __end_tp_report 05:55:52 INFO - PROCESS | 2013 | __start_cc_report 05:55:52 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,965 05:55:52 INFO - PROCESS | 2013 | __end_cc_report 05:55:52 INFO - PROCESS | 2013 | __startTimestamp1472648152277__endTimestamp 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | ------- Summary: start ------- 05:55:52 INFO - PROCESS | 2013 | Number of tests: 14 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#0] ai-astar Cycles:10 Average:136.80 Median:146.50 stddev:27.29 (18.6%) stddev-sans-first:28.05 05:55:52 INFO - PROCESS | 2013 | Values: 156.0 101.0 169.0 168.0 173.0 115.0 116.0 116.0 117.0 137.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:148.00 stddev:20.65 (14.0%) stddev-sans-first:18.35 05:55:52 INFO - PROCESS | 2013 | Values: 173.0 142.0 134.0 159.0 136.0 160.0 127.0 114.0 154.0 110.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#2] audio-dft Cycles:10 Average:199.00 Median:199.00 stddev:12.93 (6.5%) stddev-sans-first:13.69 05:55:52 INFO - PROCESS | 2013 | Values: 201.0 232.0 201.0 196.0 202.0 197.0 195.0 183.0 192.0 191.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#3] audio-fft Cycles:10 Average:84.60 Median:72.50 stddev:31.31 (43.2%) stddev-sans-first:32.82 05:55:52 INFO - PROCESS | 2013 | Values: 71.0 81.0 75.0 146.0 57.0 62.0 74.0 89.0 135.0 56.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:71.50 stddev:20.50 (28.7%) stddev-sans-first:20.80 05:55:52 INFO - PROCESS | 2013 | Values: 69.0 72.0 119.0 72.0 71.0 89.0 111.0 68.0 76.0 113.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:87.00 stddev:16.16 (18.6%) stddev-sans-first:16.74 05:55:52 INFO - PROCESS | 2013 | Values: 89.0 88.0 89.0 121.0 106.0 85.0 88.0 86.0 106.0 130.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#6] imaging-darkroom Cycles:10 Average:113.50 Median:94.00 stddev:27.45 (29.2%) stddev-sans-first:29.10 05:55:52 INFO - PROCESS | 2013 | Values: 111.0 93.0 88.0 155.0 153.0 149.0 96.0 98.0 95.0 97.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#7] imaging-desaturate Cycles:10 Average:108.40 Median:88.50 stddev:25.57 (28.9%) stddev-sans-first:26.12 05:55:52 INFO - PROCESS | 2013 | Values: 128.0 121.0 87.0 149.0 148.0 89.0 91.0 92.0 91.0 88.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:1.35 (2.3%) stddev-sans-first:1.09 05:55:52 INFO - PROCESS | 2013 | Values: 55.0 57.0 59.0 58.0 58.0 59.0 59.0 57.0 57.0 56.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:72.50 stddev:11.32 (15.6%) stddev-sans-first:11.36 05:55:52 INFO - PROCESS | 2013 | Values: 67.0 69.0 70.0 74.0 70.0 90.0 100.0 89.0 73.0 72.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#10] stanford-crypto-aes Cycles:10 Average:97.20 Median:83.00 stddev:12.46 (15.0%) stddev-sans-first:12.01 05:55:52 INFO - PROCESS | 2013 | Values: 112.0 108.0 85.0 88.0 87.0 87.0 81.0 106.0 108.0 110.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#11] stanford-crypto-ccm Cycles:10 Average:153.00 Median:156.00 stddev:16.00 (10.3%) stddev-sans-first:16.93 05:55:52 INFO - PROCESS | 2013 | Values: 156.0 158.0 150.0 138.0 140.0 166.0 133.0 145.0 188.0 156.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.70 Median:176.00 stddev:27.54 (15.6%) stddev-sans-first:23.29 05:55:52 INFO - PROCESS | 2013 | Values: 236.0 176.0 170.0 172.0 176.0 173.0 174.0 172.0 196.0 242.0 05:55:52 INFO - PROCESS | 2013 | 05:55:52 INFO - PROCESS | 2013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:79.00 stddev:11.12 (14.1%) stddev-sans-first:11.22 05:55:52 INFO - PROCESS | 2013 | Values: 67.0 70.0 70.0 64.0 65.0 79.0 79.0 90.0 93.0 90.0 05:55:52 INFO - PROCESS | 2013 | -------- Summary: end -------- 05:55:52 INFO - PROCESS | 2013 | 05:55:53 INFO - TEST-INFO | 2013: exit 0 05:55:53 INFO - TEST-OK | kraken | took 60933ms 05:55:53 INFO - SUITE-END | took 1175s 05:55:53 INFO - Completed test suite (00:19:36) 05:55:53 INFO - javascript benchmark 05:55:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7299.943659952706, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.104272367823, 3392.626811050784, 3413.8463769130385, 3421.8289085545716, 3435.793852368859, 5103.183490641493, 5164.380274367072, 5683.119116536933, 5707.971460142704, 5756.453136951994, 4745.762711864401, 5130.589552835773, 5336.265713643063, 5705.971470142654, 5766.942330576693, 5203.0, 5215.973920130394, 5263.3683957925105, 5344.0, 5360.517553420192, 5093.974530127344, 5187.714675692835, 5414.810481633143, 5428.5385742211765, 5434.972825135888, 5140.691558506502, 5284.947150528484, 5290.55030322423, 5295.391030031518, 5321.760520776555, 5164.354455693038, 5186.5332120109, 5201.08980928336, 5206.869828254286, 5249.396319423277, 5151.407588127338, 5167.199084141964, 5225.741021067817, 5233.816816411445, 5308.495692909168, 4594.816207351702, 5654.943450565483, 5694.889496548175, 5779.595428320019, 5786.826395208151, 6159.568830181889, 6177.536684748617, 6252.906206406908, 6268.87462250757, 6272.937270627281, 6185.845353866144, 6230.844228894269, 6253.624782513064, 6262.060690896356, 6289.842753931189, 4502.459704835375, 4974.129527332739, 5685.658860468385, 5807.070868660994, 5946.732397042144, 4850.902981940341, 5148.794048238104, 5437.374701909252, 5715.228444160069, 6283.748650054038, 6149.723262453201, 6172.660503672251, 6173.753049878044, 6176.258848938066, 6184.721687524072, 6101.217066730133, 6190.50475961931, 6199.690015499207, 6255.874882502416, 6277.497800175975, 6057.939420605738, 6170.876582468325, 6220.595661282093, 6244.313125556185, 6255.874882502325, 6200.193974783249, 6205.875882482325, 6297.27581328144, 6312.147860038928, 6313.2424109107205, 3973.7218394712095, 4842.394700662418, 4968.826091086795, 4969.552740253394, 4970.229614409773, 4374.21264172452, 4424.137293227854, 4451.354553589711, 4507.233770259064, 4517.435320584927, 5171.224316352502, 5875.030619947661, 5875.941240587625, 5888.322842873039, 5891.3224979127945, 6127.6782420562195, 6285.685715714196, 6291.496680265568, 6293.056041593798, 6295.496360291166, 5743.483086522233, 5803.622764520293, 5853.765849366063, 5887.646741195542, 5955.225820643289, 5419.3225846769155, 5425.348958125051, 5430.83707488776, 5436.075867102602, 5438.3473983121485, 6230.532710046855, 6351.904721429182, 6356.586821856565, 6366.9681651591445, 6371.362863713592, 6216.440520353009, 6223.0, 6246.843828904313, 6258.687065646791, 6311.211098612674, 6317.305096439296, 6329.303776584664, 6336.7148478319505, 6338.461230795434, 6349.49204063683, 6014.0678194879865, 6151.96924015395, 6235.3452887446165, 6255.53083518747, 6270.467010304175, 6174.413430724074, 6201.596896201732, 6246.937530624636, 6270.184875966095, 6281.371862813682, 4860.441049279378, 5884.6469211847425, 6141.385861413823, 6157.353477884937, 6166.383361663798, 5349.090654588807, 5963.612365196248, 6106.45041946227, 6170.722317495633, 6196.349383314687, 5797.4782269595935, 5893.852653683693, 5922.170896074639, 6031.939680603314, 6051.818445446644, 6101.359357267423, 6112.991356426318, 6117.0, 6125.601835880653, 6144.139820425234, 5828.6502809831545, 5942.702864856827, 5983.1025346196675, 5999.1901093351835, 6006.969965150146], "value": 5650.546865922979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.7583397886002, 513.8105286262302, 527.5252272954341, 539.4767075936343, 562.0529407947606, 28821.85589072057, 37242.255154896884, 37593.62406375935, 37649.30578123988, 39814.60185398149, 33414.164645883866, 36826.4476032859, 40948.0, 40978.385324220086, 41085.0, 9600.135987761118, 9819.754506137333, 9828.0, 9839.163671087967, 9877.160441362494, 9630.0, 9635.614575416976, 9757.121859032686, 9760.219182465422, 9765.853512197322, 8273.0, 8455.788605284886, 9737.95131024344, 9756.170725488342, 9767.97436269192, 9680.709578712649, 9727.27045471589, 9760.4631745254, 9767.755806104904, 9781.0, 9748.220142388593, 9814.362066465657, 9853.408795472295, 9857.0, 9863.753406164831, 39032.219355613015, 39197.60802391968, 39248.0, 39302.60697393018, 39465.21069578621, 3326.850291736878, 3360.277540328841, 3534.5228394166716, 3563.768355056913, 3712.0, 30065.849670751726, 30255.94104206364, 30449.695503044906, 30593.694063059305, 31424.37151256985, 3211.341674956628, 3251.252211991255, 3266.7549933755063, 3305.7024867761775, 3388.508666243381, 459121.0, 460143.0, 464253.0, 466178.0, 468289.0, 55373.446265537634, 55711.0, 55962.72018639962, 56089.158662620095, 56113.43886561082, 28898.133056008355, 32862.67137328644, 34337.65662343395, 58128.0, 58226.4177358221, 16154.353825846834, 16239.0, 16295.429659961845, 16440.0, 16511.00933943967, 12624.55814046504, 12694.873051269555, 12709.745805084032, 12715.364231788373, 12721.427535760913, 17868.9106554469, 18452.35416760407, 18471.445856624323, 18474.630507390048, 18490.075496225403, 6736.126727131918, 7880.911558437018, 7928.246816552418, 8023.83952320962, 8062.919370806334, 827.3629305434781, 967.888692800337, 975.5463709375033, 993.2554270400693, 1014.1531820929606, 24741.752582473946, 28855.278618034718, 29348.119556412916, 29590.852045739633, 30357.089287321414, 879.6877108626345, 914.9130832570895, 1037.159900480613, 1065.9786804263872, 1131.7623299107279, 15238.771418428732, 15257.6185595361, 15424.845751542342, 15446.0, 15831.683366332609, 656297.7185114044, 658733.0, 659174.4082559209, 662767.0, 663046.0, 55341.0, 55665.0, 55764.0, 55806.0, 55867.441325586224, 1346.7037251804588, 1376.566381589796, 1396.8882489400823, 1401.6355747505518, 1404.1294397473632, 23695.0, 25975.740242598087, 28484.287892802844, 29551.41952997289, 29622.407551849272, 43158.0, 44280.7785961081, 47438.52561474341, 47921.0, 47956.5204347952, 552427.0, 553804.0, 554227.0, 560894.0, 564963.0, 25517.48965020652, 25557.105501307364, 25710.68603825665, 26037.0, 26047.0, 35668.46497302595, 41957.0, 46117.53882461267, 46355.76822115868, 46639.0, 32056.83971580127, 33140.0, 38533.4219986706, 39356.606433935296, 39446.01384965399, 29947.850260748557, 37587.81206093952, 38264.0, 38819.0, 39719.0, 31327.0, 37138.0, 37142.628573714996, 37221.25557488889, 37507.81246093752, 30059.849700751358, 31625.418729063917, 33180.83409582936, 33741.0, 34954.65045349616, 21524.476359078977, 23291.373160723473, 24280.907359168526, 24524.75475245225, 25327.87336063308], "value": 19267.307534576874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.8309802843649, 375.92857357102133, 382.89853188904925, 389.68435567190596, 405.8964963934196, 18435.44693659189, 19268.518287042814, 20035.39893803188, 20961.68557471639, 21192.894035529822, 20235.0, 20396.286129985452, 21058.052387642554, 21359.893200534014, 21361.893190534025, 5932.525397968152, 5969.432903874136, 6091.0, 6141.508679305645, 6155.476784473325, 4258.084511829956, 6083.969580152093, 6130.938690613081, 6134.0, 6431.29255781866, 6644.335566443341, 6787.728490860384, 6791.694373753168, 6796.660166991655, 6798.18421789386, 5572.108462645978, 5905.793297234576, 5919.230500034968, 5980.790672326491, 6773.593584384928, 5664.178694089334, 5685.0, 5738.512226460756, 5739.540836733051, 5747.224124743189, 13131.803022954664, 13213.86786132136, 13316.134451260734, 21711.697298162002, 25133.37166570832, 2253.785890340415, 2296.0700916128994, 2309.561183375153, 2471.283327834926, 2800.7339302766204, 9748.073932976356, 9924.45415502147, 10132.138768204712, 10188.490575471196, 13397.933010334886, 1692.4161164398263, 1739.2684753868266, 1765.3291749135374, 1795.7485951966605, 1807.9819201808077, 117339.4133029338, 120642.0, 121633.0, 123907.76092239052, 125763.0, 11200.10399168081, 11509.309441433541, 11539.076873850072, 11622.07023438123, 11775.470103845348, 14343.85656143446, 14382.712345753027, 14482.131072135706, 14494.710105797825, 14522.273886305642, 8486.702965396305, 8567.228949394585, 8619.051904290523, 8664.003639581402, 8757.2994160467, 8402.369822263354, 8443.197896199852, 8498.362622803315, 8623.626565192744, 8754.86867696985, 3695.334839728821, 4463.509014008457, 4467.195904737178, 4486.775661216926, 4571.062932098912, 1561.5705680937833, 1654.1481137214344, 1895.8388536974235, 1901.6196760647927, 1923.9326623568109, 726.8769750735127, 816.3428440105653, 900.5092224737534, 919.1543779722671, 992.8758905136858, 20276.479264055255, 20808.342114594256, 21993.780062199494, 22038.11847526081, 22067.779322206574, 833.329170018129, 851.4082712514867, 868.8783570300163, 912.6942474271193, 945.808281565219, 7897.775844744074, 7998.84002319962, 9960.900390995997, 11042.668719938414, 11073.446327683745, 411648.0, 414642.0, 415128.0, 415195.0, 416041.0, 127346.36326818306, 130828.3458582701, 133719.33140334237, 135609.96585051232, 144263.0, 852.4203541591777, 879.8957308577694, 883.4081165619051, 884.7436639971256, 960.13108137136, 17263.741043884602, 19151.904240478707, 19602.019899004707, 19684.90157549203, 19806.702899456806, 53594.51635643671, 54498.45501545093, 55052.17421738597, 55258.72370638121, 55478.0, 77341.61329193543, 77968.28696647266, 78708.60645696735, 78921.60539197497, 79825.0, 7831.843363132592, 8032.959835200787, 8043.0750463695085, 8121.9593902032475, 8245.381596380175, 11177.88822111801, 12310.446029928853, 12632.2420654761, 12638.747225055631, 12754.107212495037, 7961.6019199040975, 9452.243820494481, 10171.593136274467, 10617.0, 11001.00990910822, 9425.821772278465, 10279.383237005804, 10622.628208012682, 10704.090152336827, 10899.618513351994, 11087.22389432732, 11118.944405277922, 11336.94331528337, 11348.978591926767, 11359.716007099889, 7219.891701624375, 7343.412526997934, 8062.717804876801, 8146.67413303485, 8182.345412366877, 9261.212796912068, 10855.782884342427, 10966.835497467704, 11115.888841111486, 11244.887551124712], "value": 9301.155139689437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.0791421190177, 1540.6918616276744, 1767.1959258537358, 1859.0425930645729, 1887.5182981359635, 7998.520088794662, 8514.574271286441, 8722.781930451742, 9122.817543649124, 9132.452052876832, 8731.869021964676, 8869.29045676346, 8932.59803308851, 8934.821303573925, 8942.91057089429, 2355.364051706034, 2388.4267775733874, 2392.688950436441, 2399.3281881073326, 2401.5797235483806, 2351.729551101628, 2379.0364902214546, 2387.77316154965, 2395.3532546212514, 2401.2076014915037, 2373.8100951923893, 2383.5828729972272, 2389.976100238993, 2395.3053614451874, 2403.4231784371714, 1945.6984167454068, 2328.860268383894, 2353.7410884802657, 2363.3500787283465, 2377.322463098026, 2308.1734157988244, 2308.734495533002, 2326.255308518611, 2329.9301020969397, 2331.25399872041, 7559.470837041409, 8932.732018039469, 8949.910500894974, 8967.596458159398, 8969.730908072768, 4404.471463424377, 4572.428446444194, 5355.089634762061, 5426.8914621707345, 5433.239346491494, 3354.8258109661665, 3495.94756078659, 3695.907602309937, 3776.4712940188397, 3790.507234059582, 1095.2059756676426, 1104.690686607751, 1119.6193294279983, 1119.8936101070385, 1128.424503503211, 9621.0, 9635.373700709431, 11641.767164656743, 11650.41747912601, 11746.765064698744, 4711.52884711533, 4755.738434386073, 4805.511215659895, 4870.196417591058, 4906.067847109038, 10023.2482563808, 10116.747081323027, 10118.747031324128, 10119.494025298853, 10126.240531960133, 5417.160340147283, 5433.456654334614, 5437.211604317431, 5443.0, 5453.890922181534, 4224.725392849455, 4428.911421771547, 4694.0, 4884.462709101996, 4933.580645645088, 3260.543523906655, 3925.764454132704, 4038.7172897897453, 4083.8570650027104, 4089.3252613319064, 1162.5582278734028, 1268.207370393504, 1336.2717319061135, 1338.6586420462913, 1345.4618152738788, 642.2934771751037, 784.2197013971021, 799.2127754162145, 901.715959472764, 907.3285768531372, 5902.586818922634, 5951.107333899863, 6103.115048317969, 6130.846728831815, 6298.086777417248, 915.1214833759532, 920.6615197398532, 962.2830990911815, 971.7764914069803, 1017.399734156851, 3889.105505733697, 4018.578049304839, 4105.651019663303, 4132.938005929914, 4161.167766446722, 10292.639757608447, 10690.251682382159, 10709.946450267698, 10742.516586753614, 10770.78458430827, 10621.893781062245, 10676.733081673021, 10698.144148468104, 10698.679039628823, 10710.678679639623, 6785.796426107225, 7967.322777563856, 8110.188981101843, 8195.42632015765, 8203.0, 5776.162456443876, 5846.444587764156, 5917.881642367214, 5945.108233764797, 5953.851153721192, 9901.158401535662, 10014.198864091, 10015.298929075187, 10053.346532475365, 10104.989501049837, 9584.520773961414, 9888.50557472138, 10071.446070466194, 10075.294729368874, 10179.694609161737, 6909.723611055501, 7346.742863999734, 7381.926180738124, 7582.165961744094, 7597.772066838003, 8343.54110523927, 8440.366972476966, 8447.02859171203, 8447.619857106321, 8485.95757021211, 7321.78034658961, 7443.702251910079, 7459.664315105942, 7503.024606801299, 7576.545407275581, 7352.5220860643885, 7422.517536360119, 7438.739644112647, 7496.4002879768395, 7563.054618172729, 6884.690188941409, 7019.4735394844565, 7027.543209691354, 7028.894566581607, 7035.929640703527, 4981.1283025469675, 5056.82301119459, 5111.284420181252, 5149.716765577929, 5158.767855446439, 4015.357542793139, 5093.6179786516905, 5187.792488300577, 5271.65734227274, 5282.418933917343], "value": 4592.893886755883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.4321919278124, 315.55821849410825, 316.5204714856991, 321.7988757026859, 322.3729845450598, 4671.696339737915, 4822.4454187768415, 5073.923891141631, 5321.441248668887, 5636.323641163061, 4321.848735294266, 4672.602828759551, 5506.944930550693, 5513.754409104987, 5609.551235901128, 4043.555208927016, 4120.299549076664, 4133.276676581601, 4159.334506478964, 4222.514410842762, 3438.6905178533925, 3644.872429464969, 3837.366834472323, 4207.179599978005, 4253.362455454641, 4193.888619515831, 4215.5784421557755, 4217.641500472449, 4239.915201695964, 4279.379489973952, 3309.470484722457, 3793.2603142387247, 4129.442525259096, 4254.595813397737, 4261.957380426218, 2982.567527708492, 3168.651448340681, 3593.802340871251, 3637.654422829827, 3660.103274697716, 5046.7224302663335, 5341.786328546854, 5367.46325367464, 5394.568434525228, 5423.023855705971, 4429.224885645, 4630.398048253739, 4670.346151538787, 4774.904501909942, 4865.537773911473, 4416.823327066913, 5097.617678674114, 5837.50381217597, 5868.2371291732225, 5902.527797776168, 3368.96631033689, 4029.738067025634, 4054.290499162664, 4055.7566546007333, 4092.3656833190903, 4960.553550180501, 6100.176476175659, 6161.260648722137, 6173.444390004876, 6184.381561843779, 4099.528554216244, 4136.793160341971, 4174.415581818548, 4176.2691528982305, 4201.264778663722, 4237.855778939731, 4238.054552086271, 4246.0, 4260.403543503912, 4307.698461107692, 3763.41667041609, 4476.462824461086, 4705.317728929286, 4923.59677491913, 4960.528749768766, 4941.985388912761, 5616.001758434996, 5884.558658100659, 5939.613925094855, 5945.851353716105, 1110.838928355384, 1440.7262620102147, 1453.542134227715, 1454.0984589554544, 1462.3638717158071, 769.5728870476827, 835.8620827563506, 847.9951257759575, 853.7918844834613, 877.4954401219197, 4259.850905218303, 4472.993576445274, 4487.887802804956, 4840.564349208588, 5507.449255074541, 5357.303550538483, 5454.990826697073, 6043.791241751667, 6061.333253342129, 6101.542384321194, 5145.614078944094, 5187.403448603383, 5506.2841830562575, 5540.69793598504, 5544.805931792368, 2713.71505991872, 2724.50958827413, 3138.5449109879396, 3144.0349781386635, 3200.6159260888844, 5637.013522633522, 5911.704414779244, 6115.357887421846, 6216.844578885473, 6284.591501552384, 5409.350877894599, 5914.4381283777975, 5948.226730525004, 6082.026875699955, 6130.846728831815, 5030.773615187252, 5475.835724928259, 6041.818745437644, 6148.354422785543, 6168.506519478431, 5329.49369809883, 5678.630888992202, 5996.340402555803, 6017.669028203491, 6034.788782392595, 4951.628627852853, 5585.31904685745, 5897.351291358033, 5964.135200395832, 6030.90953635687, 4661.976690116528, 5545.146123444168, 5755.769769209185, 5991.071383935497, 6174.289956655042, 3924.293627147141, 3933.5642490491337, 4102.548719640897, 4111.383292506148, 4133.669306455537, 5215.55667768244, 5263.9210411844615, 5690.687012214203, 5979.910301345396, 5983.431574000463, 4636.65225108125, 5039.244113383022, 5109.6750978304035, 5438.945610543844, 5722.284714410699, 5212.98346822366, 5492.752826122754, 5553.805616803393, 5879.176915231786, 5889.411058894077, 4795.328653988375, 4833.694902376409, 5029.572486338702, 5532.640378375393, 5823.475887170175, 5288.497592728685, 5460.907818436249, 5638.956792993309, 5727.079189613411, 5763.366029736641, 4816.903661926812, 5367.329083864517, 5685.744141513559, 5706.629069110494, 5761.510271626791], "value": 4175.673053952178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.6603230449384, 716.6560051175436, 735.1362149474367, 766.9233076692328, 777.1179711027984, 15315.617109572253, 16331.755023674654, 16390.83609163908, 16487.422940197095, 16507.587310317234, 14657.0, 14743.705125897503, 14760.114393136393, 14765.926170369134, 14828.110313381178, 683.6240067962625, 836.2139588786551, 842.4608250719529, 854.3848429131046, 866.5450638414819, 828.5484410995991, 845.7293666026874, 846.7459762071354, 847.2755793796308, 850.1158794853345, 886.330820230725, 895.042304733935, 904.5160838951163, 907.8184363127368, 908.6274627402767, 876.430320291809, 902.4179404284233, 903.584351198443, 904.0642934562761, 904.4347282948157, 670.0351493848842, 673.5857447669697, 673.6800019990515, 676.0130209893562, 679.3478260869522, 5883.23517942669, 5926.911096333559, 7069.081019467488, 14929.701405971928, 15148.924255378763, 12921.67695807603, 14802.925985370111, 14807.111573305636, 14908.329125189284, 15015.699686006328, 11946.88053119475, 12005.819912701316, 12043.0, 12044.096692748079, 12126.05459057072, 3843.3658446356317, 3875.283072631544, 3876.1472476055224, 3896.2012787378803, 4034.245103380039, 103583.0, 114893.4255328718, 117835.0, 119676.40161799222, 125080.74919250872, 11281.21031527785, 11340.94329528347, 11390.088792896548, 11452.370119643332, 11550.249233799776, 20197.596048078954, 24044.87977560136, 24049.639255411184, 24090.759092409204, 24094.39764005879, 8074.192580741878, 8269.751907442786, 8295.253427191581, 8359.331253499706, 8426.368022398345, 3886.8639597613947, 4433.911321773611, 4526.049529598756, 4565.657575681837, 4606.0, 2815.8595768713703, 2886.278430392402, 2916.5916771651987, 3338.4825352070466, 3619.728520360931, 642.4410762636536, 657.5167252069725, 665.1087542692815, 678.3860606151441, 688.1948120698794, 601.4122716029685, 618.245740196968, 624.8000639795222, 644.2301449767483, 658.7793089315134, 7762.961185194151, 8376.120507346763, 8771.91228087711, 9304.441733496013, 9547.52262386878, 560.4731552340787, 644.8065580325883, 647.0552992630718, 666.5868359078784, 668.6706945643216, 4375.365571992043, 4526.864194074183, 4548.909021819545, 4739.392917202013, 4765.761711914391, 103359.0, 164873.0, 166152.16923915304, 171481.14259428624, 171951.14024429797, 149614.0, 150110.0, 150456.49543504426, 152389.0, 152627.23686381496, 91064.0, 94777.0, 107238.9276107229, 119048.0, 121414.3929280348, 7132.322429369202, 8983.910160898307, 9014.0, 9030.548472576476, 9075.319351048565, 67890.0, 69028.3097169022, 69221.30778692149, 69370.0, 70484.29515704777, 87920.0, 96903.0, 105827.0, 106440.46779766052, 107748.0, 11727.413629318671, 11790.587329443428, 12052.698682533006, 12097.57658481949, 12485.812712809497, 13220.405081771536, 13431.798523021967, 13724.245166515539, 13857.653558660711, 13915.98983506885, 11821.113416493625, 12471.376431178587, 12621.242725436136, 12676.112672112864, 13196.88467636487, 13737.725245495234, 13882.51411200603, 13980.860191397956, 14184.219867906952, 14454.494092706705, 13746.587602371945, 13778.311084445537, 14196.515609768456, 14218.857811421753, 14459.13245205291, 11399.601013964471, 11511.194216405107, 11526.464177880853, 11755.177137600285, 11932.880671193177, 8463.49219046859, 9773.966407300104, 10240.64157754475, 11541.941385533008, 11674.474648640662], "value": 7791.343015433512, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1618.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 101.0, 169.0, 168.0, 173.0, 115.0, 116.0, 116.0, 117.0, 137.0], "value": 136.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 142.0, 134.0, 159.0, 136.0, 160.0, 127.0, 114.0, 154.0, 110.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 232.0, 201.0, 196.0, 202.0, 197.0, 195.0, 183.0, 192.0, 191.0], "value": 199.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 75.0, 146.0, 57.0, 62.0, 74.0, 89.0, 135.0, 56.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 119.0, 72.0, 71.0, 89.0, 111.0, 68.0, 76.0, 113.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 121.0, 106.0, 85.0, 88.0, 86.0, 106.0, 130.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 93.0, 88.0, 155.0, 153.0, 149.0, 96.0, 98.0, 95.0, 97.0], "value": 113.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 87.0, 149.0, 148.0, 89.0, 91.0, 92.0, 91.0, 88.0], "value": 108.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 59.0, 58.0, 58.0, 59.0, 59.0, 57.0, 57.0, 56.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 74.0, 70.0, 90.0, 100.0, 89.0, 73.0, 72.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 85.0, 88.0, 87.0, 87.0, 81.0, 106.0, 108.0, 110.0], "value": 97.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 150.0, 138.0, 140.0, 166.0, 133.0, 145.0, 188.0, 156.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [236.0, 176.0, 170.0, 172.0, 176.0, 173.0, 174.0, 172.0, 196.0, 242.0], "value": 188.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 70.0, 64.0, 65.0, 79.0, 79.0, 90.0, 93.0, 90.0], "value": 76.7, "unit": "score"}]}]} 05:55:53 INFO - Return code: 0 05:55:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:55:53 ERROR - # TBPL SUCCESS # 05:55:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:55:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:55:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:55:53 INFO - 2016-08-31 05:55:53.550 screenresolution[2018:282479] starting screenresolution argv=screenresolution get 05:55:53 INFO - 2016-08-31 05:55:53.552 screenresolution[2018:282479] Display 0: 1600x1200x32@60 05:55:53 INFO - 2016-08-31 05:55:53.558 screenresolution[2019:282482] starting screenresolution argv=screenresolution list 05:55:53 INFO - Available Modes on Display 0 05:55:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:55:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:55:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:55:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:55:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:55:53 INFO - Intel Iris: 05:55:53 INFO - Chipset Model: Intel Iris 05:55:53 INFO - Type: GPU 05:55:53 INFO - Bus: Built-In 05:55:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:55:53 INFO - Vendor: Intel (0x8086) 05:55:53 INFO - Device ID: 0x0a2e 05:55:53 INFO - Revision ID: 0x0009 05:55:53 INFO - Displays: 05:55:53 INFO - Display: 05:55:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:55:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:55:53 INFO - Display Serial Number: 1600x1200 60 05:55:53 INFO - Main Display: Yes 05:55:53 INFO - Mirror: Off 05:55:53 INFO - Online: Yes 05:55:53 INFO - Rotation: Supported 05:55:53 INFO - Return code: 0 05:55:53 INFO - Running post-action listener: _resource_record_post_action 05:55:53 INFO - [mozharness: 2016-08-31 12:55:53.795030Z] Finished run-tests step (success) 05:55:53 INFO - Running post-run listener: _resource_record_post_run 05:55:53 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 2378752; Write bytes: 710835200; Read time: 25; Write time: 2070 05:55:53 INFO - TinderboxPrint: CPU usage
54.5% 05:55:53 INFO - TinderboxPrint: I/O read bytes / time
2,378,752 / 25 05:55:53 INFO - TinderboxPrint: I/O write bytes / time
710,835,200 / 2,070 05:55:53 INFO - TinderboxPrint: CPU idle
2,203.5 (45.5%) 05:55:53 INFO - TinderboxPrint: CPU system
980.5 (20.2%) 05:55:53 INFO - TinderboxPrint: CPU user
1,661.7 (34.3%) 05:55:53 INFO - TinderboxPrint: Swap in / out
423,464,960 / 0 05:55:53 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385901056; Write bytes: 380889088; Read time: 28588; Write time: 830 05:55:53 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 2378752; Write bytes: 301618176; Read time: 25; Write time: 1175 05:55:54 INFO - Running post-run listener: _upload_blobber_files 05:55:54 INFO - Blob upload gear active. 05:55:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:55:54 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 05:55:54 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:55:54 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:55:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:55:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:55:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:55:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:55 INFO - (blobuploader) - INFO - Done attempting. 05:55:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:55:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:55:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:56 INFO - (blobuploader) - INFO - Done attempting. 05:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:59 INFO - (blobuploader) - INFO - Done attempting. 05:55:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:55:59 INFO - Return code: 0 05:55:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:55:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:55:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9e091c4ba2f92761ae43309bf2ad5a14ef7ffe8b5933f445861d660cb05daf158b53fec39fe229e16eab06ac9c558b46a41cef4332c7282fd94af2500ca229a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dcfc36aef79c520e0a0f8d85af58b92bdda6696b2111cd6e994c22134b995f86a93e07ea0bbae8ebca3a9763cb0a7c94290c6e0b117d54ce95063a58d5267fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d502c0837db6aec9fbc005ca383b076bd9c033f18e94b5eb3ae2d4ea66d85a403c61823b2bf60e20c37d3ea0e0593faa5d27a9138818f8be7a63757657a96c"} 05:55:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:55:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:55:59 INFO - Contents: 05:55:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9e091c4ba2f92761ae43309bf2ad5a14ef7ffe8b5933f445861d660cb05daf158b53fec39fe229e16eab06ac9c558b46a41cef4332c7282fd94af2500ca229a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dcfc36aef79c520e0a0f8d85af58b92bdda6696b2111cd6e994c22134b995f86a93e07ea0bbae8ebca3a9763cb0a7c94290c6e0b117d54ce95063a58d5267fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d502c0837db6aec9fbc005ca383b076bd9c033f18e94b5eb3ae2d4ea66d85a403c61823b2bf60e20c37d3ea0e0593faa5d27a9138818f8be7a63757657a96c"} 05:55:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:55:59 INFO - Copying logs to upload dir... 05:55:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:55:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.248741 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-31 05:55:59.323409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 05:55:59.327101) ========= 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.CvTrPclooW/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.Mt709eSaFB/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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/Firefox/sha512/d9e091c4ba2f92761ae43309bf2ad5a14ef7ffe8b5933f445861d660cb05daf158b53fec39fe229e16eab06ac9c558b46a41cef4332c7282fd94af2500ca229a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dcfc36aef79c520e0a0f8d85af58b92bdda6696b2111cd6e994c22134b995f86a93e07ea0bbae8ebca3a9763cb0a7c94290c6e0b117d54ce95063a58d5267fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d502c0837db6aec9fbc005ca383b076bd9c033f18e94b5eb3ae2d4ea66d85a403c61823b2bf60e20c37d3ea0e0593faa5d27a9138818f8be7a63757657a96c"} build_url:https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/PuG7hxlpRnqZOQR9gjNlSg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9e091c4ba2f92761ae43309bf2ad5a14ef7ffe8b5933f445861d660cb05daf158b53fec39fe229e16eab06ac9c558b46a41cef4332c7282fd94af2500ca229a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dcfc36aef79c520e0a0f8d85af58b92bdda6696b2111cd6e994c22134b995f86a93e07ea0bbae8ebca3a9763cb0a7c94290c6e0b117d54ce95063a58d5267fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d502c0837db6aec9fbc005ca383b076bd9c033f18e94b5eb3ae2d4ea66d85a403c61823b2bf60e20c37d3ea0e0593faa5d27a9138818f8be7a63757657a96c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 05:55:59.359800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:55:59.360091) ========= 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.CvTrPclooW/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.Mt709eSaFB/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.004630 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:55:59.408156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 05:55:59.408452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 05:55:59.408755) ========= ========= Total master_lag: 0.18 =========