builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1472665864.71 results: success (0) buildid: 20160831075920 builduid: 942b35445e7c4fe4a59801253ce5bf88 revision: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.710254) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.710658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.710934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.735488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.735814) ========= 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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:51:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.6M=0.001s 2016-08-31 10:51:04 (12.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.865443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.865737) ========= 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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.025355 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:04.914139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 10:51:04.914438) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a --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 b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sIZKvhpXRe/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.YFWOfFR6ug/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 10:51:04,992 truncating revision to first 12 chars 2016-08-31 10:51:04,992 Setting DEBUG logging. 2016-08-31 10:51:04,992 attempt 1/10 2016-08-31 10:51:04,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3ec8a3373e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 10:51:06,637 unpacking tar archive at: mozilla-central-b3ec8a3373e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.911533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 10:51:06.849733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:06.850444) ========= script_repo_revision: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:06.851428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:06.852124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 10:51:06.872103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-31 10:51:06.872817) ========= /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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:51:07 INFO - MultiFileLogger online at 20160831 10:51:07 in /builds/slave/test 10:51:07 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 10:51:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:07 INFO - {'append_to_log': False, 10:51:07 INFO - 'base_work_dir': '/builds/slave/test', 10:51:07 INFO - 'blob_upload_branch': 'Firefox', 10:51:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:07 INFO - 'branch': 'Firefox', 10:51:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:07 INFO - 'config_files': ('talos/mac_config.py',), 10:51:07 INFO - 'default_actions': ('clobber', 10:51:07 INFO - 'read-buildbot-config', 10:51:07 INFO - 'download-and-extract', 10:51:07 INFO - 'populate-webroot', 10:51:07 INFO - 'create-virtualenv', 10:51:07 INFO - 'install', 10:51:07 INFO - 'run-tests'), 10:51:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:07 INFO - 'download_minidump_stackwalk': True, 10:51:07 INFO - 'download_symbols': 'ondemand', 10:51:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:07 INFO - 'installer_path': 'installer.exe', 10:51:07 INFO - 'log_level': 'info', 10:51:07 INFO - 'log_name': 'talos', 10:51:07 INFO - 'log_to_console': True, 10:51:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:51:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:51:07 INFO - 'opt_config_files': (), 10:51:07 INFO - 'pip_index': False, 10:51:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:51:07 INFO - 'cmd': ('bash', 10:51:07 INFO - '-c', 10:51:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:51:07 INFO - 'enabled': True, 10:51:07 INFO - 'halt_on_failure': False, 10:51:07 INFO - 'name': 'check_screen_resolution'},), 10:51:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:51:07 INFO - 'cmd': ('bash', 10:51:07 INFO - '-c', 10:51:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:51:07 INFO - 'enabled': True, 10:51:07 INFO - 'halt_on_failure': False, 10:51:07 INFO - 'name': 'check_screen_resolution'},), 10:51:07 INFO - 'run_cmd_checks_enabled': True, 10:51:07 INFO - 'sps_profile': False, 10:51:07 INFO - 'sps_profile_interval': 0, 10:51:07 INFO - 'suite': 'dromaeojs-e10s', 10:51:07 INFO - 'system_bits': '32', 10:51:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:07 INFO - 'title': 't-yosemite-r7-0014', 10:51:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:07 INFO - 'use_talos_json': True, 10:51:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:07 INFO - 'work_dir': 'build'} 10:51:07 INFO - [mozharness: 2016-08-31 17:51:07.075759Z] Running clobber step. 10:51:07 INFO - Running pre-action listener: _resource_record_pre_action 10:51:07 INFO - Running main action method: clobber 10:51:07 INFO - rmtree: /builds/slave/test/build 10:51:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - [mozharness: 2016-08-31 17:51:09.223304Z] Finished clobber step (success) 10:51:09 INFO - [mozharness: 2016-08-31 17:51:09.223430Z] Running read-buildbot-config step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: read_buildbot_config 10:51:09 INFO - Using buildbot properties: 10:51:09 INFO - { 10:51:09 INFO - "project": "", 10:51:09 INFO - "product": "firefox", 10:51:09 INFO - "script_repo_revision": "production", 10:51:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:51:09 INFO - "repository": "", 10:51:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:51:09 INFO - "buildid": "20160831075920", 10:51:09 INFO - "pgo_build": "False", 10:51:09 INFO - "basedir": "/builds/slave/test", 10:51:09 INFO - "buildnumber": 53, 10:51:09 INFO - "slavename": "t-yosemite-r7-0014", 10:51:09 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:51:09 INFO - "platform": "yosemite_r7", 10:51:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:51:09 INFO - "branch": "mozilla-central", 10:51:09 INFO - "repo_path": "mozilla-central", 10:51:09 INFO - "revision": "b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a", 10:51:09 INFO - "stage_platform": "macosx64", 10:51:09 INFO - "builduid": "942b35445e7c4fe4a59801253ce5bf88", 10:51:09 INFO - "slavebuilddir": "test" 10:51:09 INFO - } 10:51:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - [mozharness: 2016-08-31 17:51:09.226844Z] Finished read-buildbot-config step (success) 10:51:09 INFO - [mozharness: 2016-08-31 17:51:09.226948Z] Running download-and-extract step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: download_and_extract 10:51:09 INFO - mkdir: /builds/slave/test/build/tests 10:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:09 INFO - trying https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 10:51:10 INFO - Downloaded 1199 bytes. 10:51:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:51:10 INFO - Using the following test package requirements: 10:51:10 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:51:10 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:51:10 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:51:10 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'jsshell-mac.zip'], 10:51:10 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:51:10 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:51:10 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:51:10 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:51:10 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:51:10 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:51:10 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:51:10 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:10 INFO - trying https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:51:10 INFO - Downloading https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:51:11 INFO - Downloaded 16396903 bytes. 10:51:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:51:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:18 INFO - trying https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:51:18 INFO - Downloading https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:51:19 INFO - Downloaded 16396903 bytes. 10:51:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:25 INFO - trying https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:51:25 INFO - Downloading https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:51:26 INFO - Downloaded 14413998 bytes. 10:51:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:27 INFO - trying https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:51:27 INFO - Downloading https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:51:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 10:51:29 INFO - Downloaded 111581443 bytes. 10:51:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:51:29 INFO - mkdir: /builds/slave/test/properties 10:51:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:29 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:29 INFO - Contents: 10:51:29 INFO - build_url:https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:51:30 INFO - Running post-action listener: _resource_record_post_action 10:51:30 INFO - Running post-action listener: set_extra_try_arguments 10:51:30 INFO - [mozharness: 2016-08-31 17:51:30.733645Z] Finished download-and-extract step (success) 10:51:30 INFO - [mozharness: 2016-08-31 17:51:30.733765Z] Running populate-webroot step. 10:51:30 INFO - Running pre-action listener: _resource_record_pre_action 10:51:30 INFO - Running main action method: populate_webroot 10:51:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:30 INFO - '--tppagecycles', 10:51:30 INFO - '7'], 10:51:30 INFO - 'tests': ['tsvgm']}}, 10:51:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['damp', 'tps']}, 10:51:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'tests': ['damp', 'tps']}, 10:51:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['dromaeo_dom']}, 10:51:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['basic_compositor_video']}, 10:51:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['a11yr', 10:51:30 INFO - 'ts_paint', 10:51:30 INFO - 'tpaint', 10:51:30 INFO - 'sessionrestore', 10:51:30 INFO - 'sessionrestore_no_auto_restore', 10:51:30 INFO - 'tabpaint']}, 10:51:30 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:30 INFO - 'ts_paint', 10:51:30 INFO - 'tpaint', 10:51:30 INFO - 'sessionrestore', 10:51:30 INFO - 'sessionrestore_no_auto_restore', 10:51:30 INFO - 'tabpaint']}, 10:51:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:30 INFO - 'ts_paint', 10:51:30 INFO - 'tpaint', 10:51:30 INFO - 'sessionrestore', 10:51:30 INFO - 'sessionrestore_no_auto_restore', 10:51:30 INFO - 'tabpaint']}, 10:51:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:30 INFO - 'ts_paint', 10:51:30 INFO - 'tpaint', 10:51:30 INFO - 'sessionrestore', 10:51:30 INFO - 'sessionrestore_no_auto_restore', 10:51:30 INFO - 'tabpaint']}, 10:51:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['a11yr', 10:51:30 INFO - 'ts_paint', 10:51:30 INFO - 'tpaint', 10:51:30 INFO - 'sessionrestore', 10:51:30 INFO - 'sessionrestore_no_auto_restore', 10:51:30 INFO - 'tabpaint']}, 10:51:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['a11yr', 10:51:30 INFO - 'ts_paint', 10:51:30 INFO - 'tpaint', 10:51:30 INFO - 'sessionrestore', 10:51:30 INFO - 'sessionrestore_no_auto_restore', 10:51:30 INFO - 'tabpaint']}, 10:51:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['tsvgx', 10:51:30 INFO - 'tsvgr_opacity', 10:51:30 INFO - 'tart', 10:51:30 INFO - 'tscrollx', 10:51:30 INFO - 'cart']}, 10:51:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:30 INFO - 'tsvgr_opacity', 10:51:30 INFO - 'tart', 10:51:30 INFO - 'tscrollx', 10:51:30 INFO - 'cart']}, 10:51:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'talos_options': ['--disable-e10s'], 10:51:30 INFO - 'tests': ['tp5o']}, 10:51:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'tests': ['tp5o']}, 10:51:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'talos_options': ['--disable-e10s', 10:51:30 INFO - '--xperf_path', 10:51:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:30 INFO - 'tests': ['tp5n']}, 10:51:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:30 INFO - 'talos_options': ['--xperf_path', 10:51:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:30 INFO - 'tests': ['tp5n']}}, 10:51:30 INFO - 'talos.zip': {'path': '', 10:51:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:30 INFO - Running post-action listener: _resource_record_post_action 10:51:30 INFO - [mozharness: 2016-08-31 17:51:30.752515Z] Finished populate-webroot step (success) 10:51:30 INFO - [mozharness: 2016-08-31 17:51:30.752622Z] Running create-virtualenv step. 10:51:30 INFO - Running pre-action listener: _resource_record_pre_action 10:51:30 INFO - Running main action method: create_virtualenv 10:51:30 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:51:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:30 INFO - Using real prefix '/tools/python27' 10:51:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:31 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:34 INFO - Installing pip.................done. 10:51:34 INFO - Return code: 0 10:51:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:34 INFO - 'HOME': '/Users/cltbld', 10:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:34 INFO - 'LOGNAME': 'cltbld', 10:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:34 INFO - 'MOZ_NO_REMOTE': '1', 10:51:34 INFO - 'NO_EM_RESTART': '1', 10:51:34 INFO - 'PAGER': '/bin/cat', 10:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:34 INFO - 'PWD': '/builds/slave/test', 10:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:34 INFO - 'SHELL': '/bin/bash', 10:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:34 INFO - 'USER': 'cltbld', 10:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:34 INFO - 'XPC_FLAGS': '0x0', 10:51:34 INFO - 'XPC_SERVICE_NAME': '0', 10:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:51:34 INFO - Cleaning up... 10:51:34 INFO - Return code: 0 10:51:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:34 INFO - 'HOME': '/Users/cltbld', 10:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:34 INFO - 'LOGNAME': 'cltbld', 10:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:34 INFO - 'MOZ_NO_REMOTE': '1', 10:51:34 INFO - 'NO_EM_RESTART': '1', 10:51:34 INFO - 'PAGER': '/bin/cat', 10:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:34 INFO - 'PWD': '/builds/slave/test', 10:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:34 INFO - 'SHELL': '/bin/bash', 10:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:34 INFO - 'USER': 'cltbld', 10:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:34 INFO - 'XPC_FLAGS': '0x0', 10:51:34 INFO - 'XPC_SERVICE_NAME': '0', 10:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:35 INFO - Downloading/unpacking psutil>=3.1.1 10:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:38 INFO - Installing collected packages: psutil 10:51:38 INFO - Running setup.py install for psutil 10:51:38 INFO - building 'psutil._psutil_osx' extension 10:51:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:51:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:51:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:51:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:51:39 INFO - building 'psutil._psutil_posix' extension 10:51:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:51:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:51:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:51:39 INFO - ^ 10:51:39 INFO - 1 warning generated. 10:51:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:51:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:39 INFO - Successfully installed psutil 10:51:39 INFO - Cleaning up... 10:51:39 INFO - Return code: 0 10:51:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:39 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:39 INFO - 'HOME': '/Users/cltbld', 10:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:39 INFO - 'LOGNAME': 'cltbld', 10:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:39 INFO - 'MOZ_NO_REMOTE': '1', 10:51:39 INFO - 'NO_EM_RESTART': '1', 10:51:39 INFO - 'PAGER': '/bin/cat', 10:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:39 INFO - 'PWD': '/builds/slave/test', 10:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:39 INFO - 'SHELL': '/bin/bash', 10:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:39 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:39 INFO - 'USER': 'cltbld', 10:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:39 INFO - 'XPC_FLAGS': '0x0', 10:51:39 INFO - 'XPC_SERVICE_NAME': '0', 10:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:42 INFO - Installing collected packages: mozsystemmonitor 10:51:42 INFO - Running setup.py install for mozsystemmonitor 10:51:42 INFO - Successfully installed mozsystemmonitor 10:51:42 INFO - Cleaning up... 10:51:42 INFO - Return code: 0 10:51:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:42 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:42 INFO - 'HOME': '/Users/cltbld', 10:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:42 INFO - 'LOGNAME': 'cltbld', 10:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:42 INFO - 'MOZ_NO_REMOTE': '1', 10:51:42 INFO - 'NO_EM_RESTART': '1', 10:51:42 INFO - 'PAGER': '/bin/cat', 10:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:42 INFO - 'PWD': '/builds/slave/test', 10:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:42 INFO - 'SHELL': '/bin/bash', 10:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:42 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:42 INFO - 'USER': 'cltbld', 10:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:42 INFO - 'XPC_FLAGS': '0x0', 10:51:42 INFO - 'XPC_SERVICE_NAME': '0', 10:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:42 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:45 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:45 INFO - warning: no files found matching '*.txt' 10:51:45 INFO - no previously-included directories found matching 'build' 10:51:45 INFO - no previously-included directories found matching 'dist' 10:51:45 INFO - no previously-included directories found matching '.git*' 10:51:45 INFO - Installing collected packages: jsonschema, functools32 10:51:45 INFO - Running setup.py install for functools32 10:51:45 INFO - warning: no files found matching '*.txt' 10:51:45 INFO - no previously-included directories found matching 'build' 10:51:45 INFO - no previously-included directories found matching 'dist' 10:51:45 INFO - no previously-included directories found matching '.git*' 10:51:45 INFO - Successfully installed jsonschema functools32 10:51:45 INFO - Cleaning up... 10:51:46 INFO - Return code: 0 10:51:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:46 INFO - 'HOME': '/Users/cltbld', 10:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:46 INFO - 'LOGNAME': 'cltbld', 10:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:46 INFO - 'MOZ_NO_REMOTE': '1', 10:51:46 INFO - 'NO_EM_RESTART': '1', 10:51:46 INFO - 'PAGER': '/bin/cat', 10:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:46 INFO - 'PWD': '/builds/slave/test', 10:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:46 INFO - 'SHELL': '/bin/bash', 10:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:46 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:46 INFO - 'USER': 'cltbld', 10:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:46 INFO - 'XPC_FLAGS': '0x0', 10:51:46 INFO - 'XPC_SERVICE_NAME': '0', 10:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:51:46 INFO - Cleaning up... 10:51:46 INFO - Return code: 0 10:51:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:46 INFO - 'HOME': '/Users/cltbld', 10:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:46 INFO - 'LOGNAME': 'cltbld', 10:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:46 INFO - 'MOZ_NO_REMOTE': '1', 10:51:46 INFO - 'NO_EM_RESTART': '1', 10:51:46 INFO - 'PAGER': '/bin/cat', 10:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:46 INFO - 'PWD': '/builds/slave/test', 10:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:46 INFO - 'SHELL': '/bin/bash', 10:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:46 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:46 INFO - 'USER': 'cltbld', 10:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:46 INFO - 'XPC_FLAGS': '0x0', 10:51:46 INFO - 'XPC_SERVICE_NAME': '0', 10:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:50 INFO - Downloading docopt-0.6.1.tar.gz 10:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:50 INFO - Running setup.py install for blobuploader 10:51:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:50 INFO - Running setup.py install for requests 10:51:50 INFO - Running setup.py install for docopt 10:51:51 INFO - Successfully installed blobuploader requests docopt 10:51:51 INFO - Cleaning up... 10:51:51 INFO - Return code: 0 10:51:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:51 INFO - 'HOME': '/Users/cltbld', 10:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:51 INFO - 'LOGNAME': 'cltbld', 10:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:51 INFO - 'MOZ_NO_REMOTE': '1', 10:51:51 INFO - 'NO_EM_RESTART': '1', 10:51:51 INFO - 'PAGER': '/bin/cat', 10:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:51 INFO - 'PWD': '/builds/slave/test', 10:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:51 INFO - 'SHELL': '/bin/bash', 10:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:51 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:51 INFO - 'USER': 'cltbld', 10:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:51 INFO - 'XPC_FLAGS': '0x0', 10:51:51 INFO - 'XPC_SERVICE_NAME': '0', 10:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:51 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-bxr8zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:51 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-pLXGyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:51 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-t7p1g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:51 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-71Bkin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:51 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-C6JBCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:51 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-0S770_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-uswNUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-68VhXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-45uQW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Mc79vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gXMTDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-h6v_z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-oqkYco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-pHD4Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-m7_TbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-4yUlRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-bWjucM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:53 INFO - Running setup.py install for manifestparser 10:51:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:53 INFO - Running setup.py install for mozcrash 10:51:53 INFO - Running setup.py install for mozdebug 10:51:53 INFO - Running setup.py install for mozdevice 10:51:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:53 INFO - Running setup.py install for mozfile 10:51:53 INFO - Running setup.py install for mozhttpd 10:51:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Running setup.py install for mozinfo 10:51:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Running setup.py install for mozInstall 10:51:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Running setup.py install for mozleak 10:51:54 INFO - Running setup.py install for mozlog 10:51:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Running setup.py install for moznetwork 10:51:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:54 INFO - Running setup.py install for mozprocess 10:51:55 INFO - Running setup.py install for mozprofile 10:51:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:55 INFO - Running setup.py install for mozrunner 10:51:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:55 INFO - Running setup.py install for mozscreenshot 10:51:55 INFO - Running setup.py install for moztest 10:51:55 INFO - Running setup.py install for mozversion 10:51:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:55 INFO - Cleaning up... 10:51:55 INFO - Return code: 0 10:51:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:55 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:55 INFO - 'HOME': '/Users/cltbld', 10:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:55 INFO - 'LOGNAME': 'cltbld', 10:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:55 INFO - 'MOZ_NO_REMOTE': '1', 10:51:55 INFO - 'NO_EM_RESTART': '1', 10:51:55 INFO - 'PAGER': '/bin/cat', 10:51:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:55 INFO - 'PWD': '/builds/slave/test', 10:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:55 INFO - 'SHELL': '/bin/bash', 10:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:51:55 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:55 INFO - 'USER': 'cltbld', 10:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:55 INFO - 'XPC_FLAGS': '0x0', 10:51:55 INFO - 'XPC_SERVICE_NAME': '0', 10:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-SfRL8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-AOsZsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-VuHIKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-XMYVzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-cogryo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-NkDNkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-A_3HWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Ld9kcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:56 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-MZ_yGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-MpZQGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-r8aQKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-4Lvwbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PTW7mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2Ueu3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-1ZTNsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-CRmuqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Nv98a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:00 INFO - Downloading blessings-1.6.tar.gz 10:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:00 INFO - Installing collected packages: blessings 10:52:00 INFO - Running setup.py install for blessings 10:52:00 INFO - Successfully installed blessings 10:52:00 INFO - Cleaning up... 10:52:00 INFO - Return code: 0 10:52:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:01 INFO - Reading from file tmpfile_stdout 10:52:01 INFO - Current package versions: 10:52:01 INFO - blessings == 1.6 10:52:01 INFO - blobuploader == 1.2.4 10:52:01 INFO - docopt == 0.6.1 10:52:01 INFO - functools32 == 3.2.3-2 10:52:01 INFO - jsonschema == 2.5.1 10:52:01 INFO - manifestparser == 1.1 10:52:01 INFO - mozInstall == 1.12 10:52:01 INFO - mozcrash == 0.17 10:52:01 INFO - mozdebug == 0.1 10:52:01 INFO - mozdevice == 0.48 10:52:01 INFO - mozfile == 1.2 10:52:01 INFO - mozhttpd == 0.7 10:52:01 INFO - mozinfo == 0.9 10:52:01 INFO - mozleak == 0.1 10:52:01 INFO - mozlog == 3.3 10:52:01 INFO - moznetwork == 0.27 10:52:01 INFO - mozprocess == 0.23 10:52:01 INFO - mozprofile == 0.28 10:52:01 INFO - mozrunner == 6.12 10:52:01 INFO - mozscreenshot == 0.1 10:52:01 INFO - mozsystemmonitor == 0.3 10:52:01 INFO - moztest == 0.7 10:52:01 INFO - mozversion == 1.4 10:52:01 INFO - psutil == 3.1.1 10:52:01 INFO - requests == 1.2.3 10:52:01 INFO - wsgiref == 0.1.2 10:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:01 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:52:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:01 INFO - 'HOME': '/Users/cltbld', 10:52:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:01 INFO - 'LOGNAME': 'cltbld', 10:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:01 INFO - 'MOZ_NO_REMOTE': '1', 10:52:01 INFO - 'NO_EM_RESTART': '1', 10:52:01 INFO - 'PAGER': '/bin/cat', 10:52:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:01 INFO - 'PWD': '/builds/slave/test', 10:52:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:01 INFO - 'SHELL': '/bin/bash', 10:52:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:52:01 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:52:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:01 INFO - 'USER': 'cltbld', 10:52:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:01 INFO - 'XPC_FLAGS': '0x0', 10:52:01 INFO - 'XPC_SERVICE_NAME': '0', 10:52:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:01 INFO - Cleaning up... 10:52:01 INFO - Return code: 0 10:52:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:01 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 0x10303da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe0ca1720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, '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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:52:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:52:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:01 INFO - 'HOME': '/Users/cltbld', 10:52:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:01 INFO - 'LOGNAME': 'cltbld', 10:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:01 INFO - 'MOZ_NO_REMOTE': '1', 10:52:01 INFO - 'NO_EM_RESTART': '1', 10:52:01 INFO - 'PAGER': '/bin/cat', 10:52:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:01 INFO - 'PWD': '/builds/slave/test', 10:52:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:01 INFO - 'SHELL': '/bin/bash', 10:52:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:52:01 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:52:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:01 INFO - 'USER': 'cltbld', 10:52:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:01 INFO - 'XPC_FLAGS': '0x0', 10:52:01 INFO - 'XPC_SERVICE_NAME': '0', 10:52:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:52:02 INFO - Cleaning up... 10:52:02 INFO - Return code: 0 10:52:02 INFO - Running post-action listener: _resource_record_post_action 10:52:02 INFO - Running post-action listener: _start_resource_monitoring 10:52:02 INFO - Starting resource monitoring. 10:52:02 INFO - [mozharness: 2016-08-31 17:52:02.059135Z] Finished create-virtualenv step (success) 10:52:02 INFO - [mozharness: 2016-08-31 17:52:02.060203Z] Running install step. 10:52:02 INFO - Running pre-action listener: _resource_record_pre_action 10:52:02 INFO - Running main action method: install 10:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:02 INFO - Reading from file tmpfile_stdout 10:52:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:02 INFO - Reading from file tmpfile_stdout 10:52:02 INFO - Output received: 10:52:02 INFO - Usage: mozinstall [options] installer 10:52:02 INFO - Options: 10:52:02 INFO - -h, --help show this help message and exit 10:52:02 INFO - -d DEST, --destination=DEST 10:52:02 INFO - Directory to install application into. [default: 10:52:02 INFO - "/builds/slave/test"] 10:52:02 INFO - --app=APP Application being installed. [default: firefox] 10:52:02 INFO - mkdir: /builds/slave/test/build/application 10:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:52:37 INFO - Reading from file tmpfile_stdout 10:52:37 INFO - Output received: 10:52:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:52:37 INFO - Running post-action listener: _resource_record_post_action 10:52:37 INFO - [mozharness: 2016-08-31 17:52:37.358786Z] Finished install step (success) 10:52:37 INFO - [mozharness: 2016-08-31 17:52:37.358957Z] Running run-tests step. 10:52:37 INFO - Running pre-action listener: _resource_record_pre_action 10:52:37 INFO - Running main action method: run_tests 10:52:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:52:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:52:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:52:37 INFO - 2016-08-31 10:52:37.373 screenresolution[1631:7358] starting screenresolution argv=screenresolution get 10:52:37 INFO - 2016-08-31 10:52:37.375 screenresolution[1631:7358] Display 0: 1600x1200x32@60 10:52:37 INFO - 2016-08-31 10:52:37.381 screenresolution[1632:7360] starting screenresolution argv=screenresolution list 10:52:37 INFO - Available Modes on Display 0 10:52:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:52:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:52:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:52:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:52:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:52:37 INFO - Intel Iris: 10:52:37 INFO - Chipset Model: Intel Iris 10:52:37 INFO - Type: GPU 10:52:37 INFO - Bus: Built-In 10:52:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:52:37 INFO - Vendor: Intel (0x8086) 10:52:37 INFO - Device ID: 0x0a2e 10:52:37 INFO - Revision ID: 0x0009 10:52:37 INFO - Displays: 10:52:37 INFO - Display: 10:52:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:52:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:52:37 INFO - Display Serial Number: 1600x1200 60 10:52:37 INFO - Main Display: Yes 10:52:37 INFO - Mirror: Off 10:52:37 INFO - Online: Yes 10:52:37 INFO - Rotation: Supported 10:52:37 INFO - Return code: 0 10:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:37 INFO - Python 2.7.3 10:52:37 INFO - Return code: 0 10:52:37 INFO - grabbing minidump binary from tooltool 10:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:37 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 0x102fa1d30>, '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 0x102d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f99b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:52:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:52:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:52:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:37 INFO - Return code: 0 10:52:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:52:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:52:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:37 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:52:37 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sIZKvhpXRe/Render', 10:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:37 INFO - 'HOME': '/Users/cltbld', 10:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:37 INFO - 'LOGNAME': 'cltbld', 10:52:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:37 INFO - 'MOZ_NO_REMOTE': '1', 10:52:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:37 INFO - 'NO_EM_RESTART': '1', 10:52:37 INFO - 'PAGER': '/bin/cat', 10:52:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:37 INFO - 'PWD': '/builds/slave/test', 10:52:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:37 INFO - 'SHELL': '/bin/bash', 10:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YFWOfFR6ug/Listeners', 10:52:37 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:37 INFO - 'USER': 'cltbld', 10:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:37 INFO - 'XPC_FLAGS': '0x0', 10:52:37 INFO - 'XPC_SERVICE_NAME': '0', 10:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:37 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:52:37 INFO - mozversion application_buildid: 20160831075920 10:52:37 INFO - mozversion application_changeset: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a 10:52:37 INFO - mozversion application_display_name: Nightly 10:52:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:37 INFO - mozversion application_name: Firefox 10:52:37 INFO - mozversion application_remotingname: firefox 10:52:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:52:37 INFO - mozversion application_vendor: Mozilla 10:52:37 INFO - mozversion application_version: 51.0a1 10:52:37 INFO - mozversion platform_buildid: 20160831075920 10:52:37 INFO - mozversion platform_changeset: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a 10:52:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:52:37 INFO - mozversion platform_version: 51.0a1 10:52:37 INFO - using testdate: 1472665957 10:52:37 INFO - actual date: 1472665957 10:52:37 INFO - starting webserver on 'localhost:49262' 10:52:37 INFO - SUITE-START | Running 2 tests 10:52:37 INFO - TEST-START | dromaeo_css 10:52:37 INFO - operating with platform_type : mac_ 10:52:37 INFO - Initialising browser for dromaeo_css test... 10:52:37 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp9tyqB3/profile http://localhost:49262/getInfo.html) 10:52:40 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 10:52:40 INFO - PROCESS | 1642 | colorDepth:24 10:52:40 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 10:52:40 INFO - PROCESS | 1642 | __metrics 10:52:40 ERROR - PROCESS | 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 10:52:41 INFO - TEST-INFO | 1642: exit 0 10:52:41 INFO - Browser initialized. 10:52:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:41 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp9tyqB3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:53 INFO - PROCESS | 1645 | RSS: Main: 243826688 10:52:53 INFO - PROCESS | 1645 | 10:53:43 INFO - PROCESS | 1645 | 1472666023243 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:55:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 10:55:56 INFO - PROCESS | 1645 | RSS: Main: 265220096 10:55:56 INFO - PROCESS | 1645 | 10:58:58 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 10:58:59 INFO - PROCESS | 1645 | RSS: Main: 269561856 10:58:59 INFO - PROCESS | 1645 | 11:02:01 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 11:02:01 INFO - PROCESS | 1645 | RSS: Main: 274571264 11:02:01 INFO - PROCESS | 1645 | 11:05:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 11:05:04 INFO - PROCESS | 1645 | RSS: Main: 269787136 11:05:04 INFO - PROCESS | 1645 | 11:08:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 11:08:07 INFO - PROCESS | 1645 | RSS: Main: 274968576 11:08:07 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 11:11:10 INFO - PROCESS | 1645 | RSS: Main: 277766144 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | __start_tp_report 11:11:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 11:11:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 11:11:10 INFO - PROCESS | 1645 | |i|pagename|runs| 11:11:10 INFO - PROCESS | 1645 | |0;dojo.html;2801.285672153601;3399.898003059909;3411.982940085299;3439.501272315514;3479.338925604136;5692.829215123543;5695.829125126248;5700.572457065721;5760.36635970044;5854.356020837705;5570.108782594785;5702.258706368177;5705.74324155413;5776.59563830531;5835.941640583593;5169.974150129254;5211.609129315298;5271.947280527184;5327.961047595721;5344.011357898782;5195.714235717034;5395.271638328834;5399.78400863965;5400.891982160354;5411.972940135313;4345.500267469234;4732.195526760459;4808.807647694088;5116.948830511685;5206.297149884755;5220.451852555465;5236.659617124875;5267.3942496613;5271.894562108736;5299.49654782795;5179.948200517984;5190.091733946544;5191.480851914816;5191.974040129775;5244.134717771563;5569.164625306196;5655.632383895075;5692.829215123553;5693.829185124453;5719.799807006776;6082.935486289882;6124.2650881894015;6202.658853763041;6209.5342849286035;6218.968905155445;4628.935344870699;5366.034113859504;5832.883342333172;6128.785492507741;6346.460550853183;5709.286339207599;5754.338251101177;5761.8559536011935;5829.912551311733;5832.766689332421;5259.263703081571;6310.968445157745;6313.9368606314265;6318.399752023551;6356.523260755462;6173.96913015441;6190;6210.658413787195;6212.72042758077;6225.657588832658;6163.630182189083;6194.442500174916;6238.781642642486;6242.812715618538;6255.562110652301;6070.9679354509835;6106.491003209229;6168.352323006109;6181.350958149419;6212.316645169028;6087.1173679816175;6160.507159427235;6209.627422354673;6234.251889773256;6243.469305109026;4807.4471435784635;4953.925691114636;4964.851054468371;4974.37820272466;4989.376327959005;4388.9247134451625;4395.7142785718825;4412.271975124133;4444.555544445529;4458.175237581057;5781.4507621775865;5879;5888.293404791367;5902.852428689232;5908.409159084057;6109.327973922954;6285.402886725754;6296.150019747367;6311.652859092702;6313.147725057151;5772.5670574707065;5843.5325173985975;5891.116332550152;5898.439648233411;5931.40685931412;5401.270828438111;5418.512333889968;5424.674519528841;5432.701201433959;5447.700376479253;6224.937750622617;6432.163818703539;6442.16251887261;6444.452221561032;6458.06358078076;6221.875562488815;6242.063690446469;6243.625382477066;6282.057691346335;6301.527385446201;6399.168108145911;6416.48668106541;6434.356564343529;6442.549021568632;6449.032645103272;6065.787697430569;6215.254169499689;6288.11966324724;6292.590981586182;6307.180066591313;6095.075643002825;6155.815325540241;6214.720337584729;6280.466160376419;6324.083007963912;6122.448979591858;6125.571210015256;6183.659898705614;6193.81418557444;6207;5934.19888315072;6197.442230199304;6201.1628430163155;6215.81352559424;6215.906761398673;5958.1360702697;5992.490638295793;6025.6083354581815;6052.425019623129;6110.7250173741395;6148.282097649322;6194.34959329282;6197.225346831646;6210.3168651449205;6215.906761398493;5872.354041055566;6021.677238899051;6063.969680151571;6088.969555152373;6128.9693551531955 11:11:10 INFO - PROCESS | 1645 | |1;ext.html;480.2580013878558;512.4363200479473;529.6689569019363;533.7864854058377;551.2998491915265;37032.44451333229;40547.59452405479;40694.38958415626;40749.59250407495;40779.79610101953;41629.375559366556;42151.789241053826;42284.73145805623;42300;42337;9102.681406150787;9602.375845570034;9773.609055637766;9778.804423911517;9802.41185528867;7505.136909255423;7848.332891704212;8525.31797456202;9019.864702029476;9765.414075155479;9401.153896149344;9633.470159141245;9675.742153520032;9764.755881102994;9800.36297640651;8411.579421028955;9651.034896510328;9708.708738737849;9761.804763904682;9779.364341317792;9438.433693978383;9520.143187113194;9617.27870409715;9623.133917947349;9624.711258662252;39934.201315973514;39941;40035.59964400348;40115;40354;3291.670832916713;3298.967010329914;3316.2372654289647;3368.292658541709;3847.769133851978;30085.548716769266;30457.39085218283;30618.846905765553;30650.33493965122;30746.077617671282;3185.2514659055105;3185.9203519911957;3205.743540516776;3250.5774249347432;3320.3193345364384;404772;465838.67080664716;481558;482740;487706.56146719394;59581.65856780054;59825;60222.698886506165;60301;60382.39617603768;33500.49749253763;34339;34614.653853461146;60055.699721501114;60294.69852650708;14185.858141418454;16606.50180494587;16627.667446650998;16631.085290308907;16669.999800011796;12739.936300318439;12819.743605127846;12837.48650054006;12841.614751557468;12856.742865142645;18939.43181704551;18966.146523406478;19211.90394048021;19215.03924803754;19219.51951201231;7801;7919.406044546682;7923.247291507298;7965.809402414382;7974.966383572152;864.8411129087053;872;919.8160367926441;986.7732514677109;1053.8524606555088;21631;27250.5912411314;29666;29861.40277194444;30144.944926927892;925.1534845616186;976.3263348289657;1042.3693665332517;1053.3732429204765;1083.8970297821695;13022.869771302356;15121;15535.45625903088;15706.136162511171;15810.36758529669;677232.6138369277;686250;686486;687530;687830;58434.707826460595;58492.70753646205;58760.706196468745;58868.705656471444;58952;1265.8544017663844;1330.940107695156;1356.1659579358623;1391.596437033249;1402.2918426194706;22087.779122209216;23846.642300365856;25512.617310740727;25844.741552584233;30160.5475917857;36052.63947360598;49764.75117624389;50334;50473;50577.74711126568;610045.9497702483;612043.9397802983;613633;613640.3179840901;614723;23785.881070594536;26205;26454;26568;26575.468490630465;36633.816830915675;42769;43652.781736091114;44768.328475073555;47658.523414766794;38748.80625596854;38796.286160674885;38912;39833.80083099566;40755;38415.423768644054;38426.42360364541;38675.226495470495;39745;39976.200475990896;28436;37715.245695086494;37925.862224132215;38159;38261.617383825804;32066.679333207303;32933.67066329402;34346.87837459521;34939.65060349364;35073.64926350704;25072.74927250704;25170.24489265325;25246.747532525176;25257.242282731546;25901.870490647427 11:11:10 INFO - PROCESS | 1645 | |2;jquery.html;325.7231353349652;364.9142451523893;367.3076251266363;381.1006025779159;399.3410872061099;20032.69950950735;20452.693209601868;20733.585328293426;21127.577448451022;21265.787342126576;20437.693434598492;20568.485787855312;20697.482562935933;20845.68731469029;21094.94525273734;5261.842144735664;5833.358330583633;6018.6689732064715;6088.117223002662;6106.236720409949;5948.821535353946;6026.4576188143055;6052.425019623129;6057.212562366886;6059.515238780887;5742.339630942432;5809.7676092956235;5896.056630939051;5911.556633252501;5942.821715348547;5640.492355687967;5854.2389489366105;5883.058710606304;5952.404759524056;5965.284165900098;5100.744962751847;5137.897242055175;5157.149070403379;5167.586593072545;5181.35233095863;20842.583148336947;26107.347316317053;26512.93948242068;26540;26673.466530669277;2238.6530087836413;2289.645105008726;2946.9096434319226;3100.9844950775328;3172.0483854843687;14866.776998345034;15371;15581.98717083386;16103.43637972677;16148.354065837353;1827.6527459782599;1893.697008478637;1933.168737442899;1946.7566554180728;1951.6389467948475;87330.12669873284;99144;115669;115885.42057289743;115976.42011789887;10294.639687610897;10522.842157367646;10617.469126543641;10782.622608208674;10877.347359158475;11530.135239857043;13149.934250328688;13152.934235328954;13158.539451119164;13176.143550669176;7312.561246325131;7322.864955931839;7667.702887758317;8067.233612806891;8097.757067287991;8412.8317433651;8441.07148213696;8479;8588.613512391958;8597.656093756179;3768.171002379472;3822.3884178531857;3831.7700937943814;3834.5206849143856;3891.610838916086;1645.8930169538942;1895.4692686047654;1937.428458604715;1946.2604210399957;1962.9901850490655;841.9915800841914;883.430187529053;897.7620930453435;915.7527467583715;971.2618410008445;20638.793612063986;20999.580008399746;21028.894855525625;21096.894515527325;21245.362639120853;924.2698268367914;928.7445952363154;963.6579014449909;970.3062310448064;1017.2675673515057;10791.892081079246;11088.057515111306;11093.278936869077;11097.83353249702;11110.833337499944;546796;574246;579874;582878;587741;90176;120078.3996080014;134462;138438;140917;758.4880205861022;996.3175224970918;1010.9191264698953;1014.5535964175739;1016.242899040205;18196.90901545484;18586.163622636745;19458.708119377938;19473.318433854747;19580.902095489433;54820.17769733378;55243;57313.713431432574;58533;58875.41124588699;79015.60492197503;79628.2037179644;83185.58407207925;85043.5747821257;86935.56532217299;6219.40915613016;7643.617819109134;7821.569813660303;7972.920270797218;8123.83752324962;12309.26144431337;12689.492420303084;13126.934365328112;13132.606021819362;13283.66790830237;10769.13846892231;11024.559017639205;11048.502817373077;11264.155188360743;11354.091672666333;10641.467926603484;10884.727881803019;10959.50682219318;11003.304190473385;11120.165987550805;10837.620683276047;11148;11268.549258029587;11301.09591232683;11562.47968841421;7845.843083138419;7908.683652654059;7989.640466178919;8032.518048917083;8120.634571444181;10604.151667866397;10839.187060970302;10920.945395272973;11043.625620491634;11288.379139147426 11:11:10 INFO - PROCESS | 1645 | |3;mootools.html;1527.3814105287363;1555.4400415850284;1560.0951448160067;1777.7066783980645;1940.1463356123295;6251.374862513746;7888.487248328855;8577.356698247626;9029.097090290976;9041.914970203576;8643.697470588531;8811.471311721301;8813.294936405087;8828.77928051799;8832.955835220815;1859.9398342944528;1898.0320036781202;2355.5877721398774;2395.9041638334534;2401.3396316013063;2309.6304591265402;2343.144752165456;2398.2085911649115;2412.601920683085;2413.046846495642;2383.797377222938;2385.2367242482414;2390.916317928873;2407.5425669122897;2422.6244932035474;2370.2889133259955;2379.3218932604213;2392.031227352925;2396.173320204544;2407.7471865454136;2350.4476448034698;2379.0127097254617;2381.809095452274;2383.0467812874817;2386.4869053153657;8923.464592124428;8981.640734370618;8989.101089891024;8996.190342869108;9011.729648110568;5187.922181167285;5258.211268309746;5287.629865909388;5362.6782393056155;5367.382750983609;3454.9654503454894;3585.533880595532;3620.275944811022;3659.670629643345;3670.7063434925144;1066.072516910293;1099.6151347028476;1109.8945600167972;1124.0670243697712;1124.5333186727498;11581.42092895352;11659.358735269558;11686.415679216005;11691.883081169164;11695.7076073098;4519.480259770168;4585.564371384713;4795.664303498722;4799.712017278975;4807.18277892759;9840.704778856645;9958.502074896227;9980.201583873273;9981.950090249502;10006.399616022916;5331.253624492574;5342.1185504392115;5356.437574054746;5359.115745901882;5363.463653634605;4410.735355878657;4688.765561721901;4858.416989961157;4913.877153071202;4921;3923.803809809498;3975.7018223633345;4062.7968601569805;4078.1435898461655;4103.363978583325;1305.2951406240713;1308.7905935050346;1313.8423389193358;1316.5786948176492;1329.0895736420582;902.7427183252742;904.380499357942;920.6087412849512;941.8180183869338;946.0775743649887;5704.087346024616;6008.429199226067;6020.096985452217;6182.938170618237;6208.81373558794;436.12121575026345;446.28371463800136;449.5616773645735;449.93925820014533;453.37887094680497;3934.2131573684806;3978.224246272007;4080.2859499587453;4087.2234275487563;4102.097538541516;8016.358691304798;10516.68449946503;10621.097206737359;10638.468076596138;10646.574137034588;10288.485575721184;10618.362898225976;10625.946870265754;10635.840462393071;10655.200859935536;8020.639071241808;8121.431499794958;8171.836563268701;8215.260626543639;8237.46456480327;5714.714264286852;5810.273715785527;5813.82558523245;5846.6784326862435;5868.853278668067;9809.215262778818;9834.262430317898;9874.85187722199;9898.307118501923;9900.356476828983;8630.56847157627;9034.322425817958;9890.307678462439;9908.388504475892;10016.799664006534;6969.128858892638;7369.668364923484;7399.889001665087;7590.544567325978;7597.924020759942;8312.833743324978;8447.493150410995;8460.196281353261;8465.534395608302;8471.745847624581;7346.081739782528;7409.147947985835;7493;7582.772516824504;7604.505707129019;6556.377144171296;7312.96343518279;7458.776236712907;7544.283293087148;7558.773236802905;5392.379876314274;5558.999380111457;6364.77723279683;6656.267810540933;6923.273056329214;3871.3418718817306;4893.947801222755;5067.5185857343495;5152.995165942605;5166.689998600096;4083.3670781028986;4646.163690535736;5083.694978301313;5096.108181068373;5148.922766158586 11:11:10 INFO - PROCESS | 1645 | |4;prototype.html;295.7811219697424;298.47170508200475;299.51628120585264;307.8722330232953;309.97707565035375;4343.782810859456;5465.672059676423;5570.442955704428;5810.970945145279;5822.359540450552;5395.7032363220105;5659.462351076651;5737.397573254811;5757.42425757424;5793.913091303634;3747.3816820224765;4394.055278115213;4405.00887300358;4405.05291362357;4419.558044195571;3480.4257297545873;3643.9453408198765;3884.961150388502;4303.225419424502;4436.645068394537;4186.874393768192;4207.169881101715;4214.936775948363;4250.129942825162;4266.57334266574;3858.6334298241763;4103.2409004333995;4266.338717498793;4269.103488267468;4293.699441039129;2865.3839424523826;3626.4741612466046;3632.6367363263726;3655.3785856404475;3671.6328367163337;4667.929981050287;5564.944350556483;5570.2480165177585;5587.368210663061;5624.493795558378;4067.4102255172834;4834.975825120887;4888;4897.559219670246;4913.31213630092;5653.434656534355;5897.764089436418;5960;5973.253343332083;6025;3299.6040475143136;3966.7818269995137;4004.2592120457516;4011.9799401002806;4016.5581786003518;6038.818835434944;6217.906731399033;6366.458850997671;6422.967885160544;6449.645269510175;3692.9815350923072;4041.535223449341;4057.6753859691153;4087.7751723655483;4093.508778946486;4142.689298302639;4145.150244199932;4152.397902304149;4153.439285696392;4158.147579746144;4823.541763532458;4852.878678033077;4877.463479017305;4893.681910675866;4900.803967841246;4693.812247510062;5061.5950723942;5146.371807875439;5354.955783622157;6036.426539478743;1332.886704630098;1416.6458385403648;1435.2608406670572;1448.6233579269256;1467.5817392043216;763.86184584968;775.4571799740091;841.9181351962699;885.7953183670203;908.5230254116509;3927.66614837742;4113.8529025295675;4440.666949978765;4679.836205732851;4753.643476739189;4299.505556861001;4655.44134703831;4671.131547381006;5195.818146364934;5198.532132108053;4260.808263628144;4598.804310879195;4767.928481072718;4782.593479554277;4827.710337379768;3002.3544937838033;3255.9650218613365;3256.234784825564;3304.653011433813;3313.8177400243217;5701.600887937888;5738.340090889517;6219.751209951642;6257.374262573706;6553.967230163818;5347.679139251657;5559.416261292587;5982.773531426047;6388.466767975652;6444.226692796894;6511.2419646695125;6517.57635753684;6523.641199733966;6535.411812936859;6545.574537655038;5084.440711521655;5160.174372100596;6239.500839932885;6248.906266406098;6275.341089185752;5029.823956161516;5133.460986596354;5612.849365879903;5946.524278057832;6160.322364539987;6118.265808103056;6440.4525615321345;6533.18335208099;6585;6590.934090659032;3349.916252093717;3468.635793241673;3539.9734077117346;3815.0843797488956;3949.763014219156;5870.911936320873;6186.566940314135;6230.314665386894;6242.250929888442;6294.402031806971;4951.5048495150195;5267.525922666979;5347.51872331492;5493.450654934634;5719.799807006735;5478.945210547843;5809.477147056785;5917.674527900835;6067.393260673897;6128.938710613015;5337.946620533745;5534.972325138348;5932.377100404396;5963.344032156372;6009.806420656516;6090.299615544269;6117.143599896107;6128.74052533485;6136.447719705248;6182.938170618416;4566.634669226521;5588.497035266845;5655.830325090254;5952.315483719254;5978.491828194478 11:11:10 INFO - PROCESS | 1645 | |5;yui.html;617.9969100154499;682.2938258902037;690.4924880213046;714.0574441736906;724.7572063358774;15164.62088447788;15657;15846.683066338666;15950.76073858893;15976.440824571142;14763.483278085243;14859.628509287273;14870.47953321634;14897;14899.25503724815;664.7042066280507;818.0510607695089;833.2167762303416;834.0200264688997;834.7954751085992;816.4244207833493;835.7242110103651;848.0374774630777;848.9812225329598;849.5200211880268;863.2964134230614;879.5074758135432;884.7080463447079;886.7738726624701;887.5917078144062;868.891388576428;876.9649214031463;877.6313948141732;877.6752601537409;881.2113158722939;549.4862303745971;632.7026297640102;635.5900444213503;653.1574269192736;655.3708439897656;14873.851261487354;15115;15198.924005379902;15210.16344101074;15252.161131137784;11563.306201627845;14582.270886455635;14598.70802583953;14648.414063437449;14958.102513849095;11705.239159454608;11867.550989876896;11876.643700688994;11881.049516038696;11894.345810980392;3689.4834723138783;3693.8522459101605;3700.5374328208973;3718.9442158367647;3851.961480385188;122760;126550;127706.08440873395;128237;130729;9668.888077870994;11013.229073964905;11188;11321.094312454983;11638.301701897914;22580.322590322317;22675.886620567122;22699.773002269765;22713.432164196027;22720.43198920007;7501.362384197404;7527;7807.960960195162;7959.482633628795;7959.482633628912;4281.100968796525;4326.58897404746;4376.321670141069;4380.773383452638;4419.668524860648;2861.957070643942;3676.356637588411;3678.9632103679155;3679.4112941929698;3688.7602305850032;558.5085125089976;633.1452539072216;672.4553111979312;673.491513906997;714.8284411741249;618.6380967134277;648.9610623362613;649.9870002599921;655.4363247607054;662.3045801907978;9262.44425334482;9478.857817132748;9533.666321678707;9560.617575297048;9702.70891873245;521.1869483605511;612.9111278864629;628.7277946354532;677.265167293492;689.007828726632;4033.4151548025957;4124.05146816234;4491.685582009228;4611.723296602215;4715.55202255792;125326;143743;145106;147496;148584;96158.55762163573;110560.4471977635;110691;111971;123057;103149.48425257826;103746.48126759318;107038.46480767547;107140;107436;9199.23902623191;9204.21764150028;9872.65418879772;9962.800743984935;9974.55114519863;48759;59731.402685972585;62223;63073.68463157655;65115.02327464997;59739;67706;91319.54340228256;95524;98241.50879245844;12811.80782288285;12835.935820321212;12993.545225917047;13062.869371306166;13071.215727056408;14238.644033898821;14611.561653150422;14625.122492650475;14654.56036318912;14915;13498.797518037041;13577.32113394346;13638.659033524242;13777.448902044207;13815;11309.660710178709;13398.799018014543;13768.449262029406;14010.299485025911;14201.218932958787;12278.201916875732;12808.359582020676;12814.743705126031;13001.4149363277;13004.609861704164;11370.715732106764;11468.713282168013;11492.597759078391;11593.536258549564;11619.244749091282;7207.495475316678;9087.59105840252;10450.581976720847;11677.532898683958;11693.181477296848 11:11:10 INFO - PROCESS | 1645 | __end_tp_report 11:11:10 INFO - PROCESS | 1645 | __start_cc_report 11:11:10 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,385 11:11:10 INFO - PROCESS | 1645 | __end_cc_report 11:11:10 INFO - PROCESS | 1645 | __startTimestamp1472667070968__endTimestamp 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | ------- Summary: start ------- 11:11:10 INFO - PROCESS | 1645 | Number of tests: 6 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5749.34 Median:5992.49 stddev:670.57 (11.2%) stddev-sans-first:631.49 11:11:10 INFO - PROCESS | 1645 | Values: 2801.3 3399.9 3412.0 3439.5 3479.3 5692.8 5695.8 5700.6 5760.4 5854.4 5570.1 5702.3 5705.7 5776.6 5835.9 5170.0 5211.6 5271.9 5328.0 5344.0 5195.7 5395.3 5399.8 5400.9 5412.0 4345.5 4732.2 4808.8 5116.9 5206.3 5220.5 5236.7 5267.4 5271.9 5299.5 5179.9 5190.1 5191.5 5192.0 5244.1 5569.2 5655.6 5692.8 5693.8 5719.8 6082.9 6124.3 6202.7 6209.5 6219.0 4628.9 5366.0 5832.9 6128.8 6346.5 5709.3 5754.3 5761.9 5829.9 5832.8 5259.3 6311.0 6313.9 6318.4 6356.5 6174.0 6190.0 6210.7 6212.7 6225.7 6163.6 6194.4 6238.8 6242.8 6255.6 6071.0 6106.5 6168.4 6181.4 6212.3 6087.1 6160.5 6209.6 6234.3 6243.5 4807.4 4953.9 4964.9 4974.4 4989.4 4388.9 4395.7 4412.3 4444.6 4458.2 5781.5 5879.0 5888.3 5902.9 5908.4 6109.3 6285.4 6296.2 6311.7 6313.1 5772.6 5843.5 5891.1 5898.4 5931.4 5401.3 5418.5 5424.7 5432.7 5447.7 6224.9 6432.2 6442.2 6444.5 6458.1 6221.9 6242.1 6243.6 6282.1 6301.5 6399.2 6416.5 6434.4 6442.5 6449.0 6065.8 6215.3 6288.1 6292.6 6307.2 6095.1 6155.8 6214.7 6280.5 6324.1 6122.4 6125.6 6183.7 6193.8 6207.0 5934.2 6197.4 6201.2 6215.8 6215.9 5958.1 5992.5 6025.6 6052.4 6110.7 6148.3 6194.3 6197.2 6210.3 6215.9 5872.4 6021.7 6064.0 6089.0 6129.0 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:70838.11 Median:40005.90 stddev:159439.26 (398.5%) stddev-sans-first:159799.02 11:11:10 INFO - PROCESS | 1645 | Values: 480.3 512.4 529.7 533.8 551.3 37032.4 40547.6 40694.4 40749.6 40779.8 41629.4 42151.8 42284.7 42300.0 42337.0 9102.7 9602.4 9773.6 9778.8 9802.4 7505.1 7848.3 8525.3 9019.9 9765.4 9401.2 9633.5 9675.7 9764.8 9800.4 8411.6 9651.0 9708.7 9761.8 9779.4 9438.4 9520.1 9617.3 9623.1 9624.7 39934.2 39941.0 40035.6 40115.0 40354.0 3291.7 3299.0 3316.2 3368.3 3847.8 30085.5 30457.4 30618.8 30650.3 30746.1 3185.3 3185.9 3205.7 3250.6 3320.3 404772.0 465838.7 481558.0 482740.0 487706.6 59581.7 59825.0 60222.7 60301.0 60382.4 33500.5 34339.0 34614.7 60055.7 60294.7 14185.9 16606.5 16627.7 16631.1 16670.0 12739.9 12819.7 12837.5 12841.6 12856.7 18939.4 18966.1 19211.9 19215.0 19219.5 7801.0 7919.4 7923.2 7965.8 7975.0 864.8 872.0 919.8 986.8 1053.9 21631.0 27250.6 29666.0 29861.4 30144.9 925.2 976.3 1042.4 1053.4 1083.9 13022.9 15121.0 15535.5 15706.1 15810.4 677232.6 686250.0 686486.0 687530.0 687830.0 58434.7 58492.7 58760.7 58868.7 58952.0 1265.9 1330.9 1356.2 1391.6 1402.3 22087.8 23846.6 25512.6 25844.7 30160.5 36052.6 49764.8 50334.0 50473.0 50577.7 610045.9 612043.9 613633.0 613640.3 614723.0 23785.9 26205.0 26454.0 26568.0 26575.5 36633.8 42769.0 43652.8 44768.3 47658.5 38748.8 38796.3 38912.0 39833.8 40755.0 38415.4 38426.4 38675.2 39745.0 39976.2 28436.0 37715.2 37925.9 38159.0 38261.6 32066.7 32933.7 34346.9 34939.7 35073.6 25072.7 25170.2 25246.7 25257.2 25901.9 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:34270.19 Median:26526.47 stddev:95922.05 (361.6%) stddev-sans-first:96157.27 11:11:10 INFO - PROCESS | 1645 | Values: 325.7 364.9 367.3 381.1 399.3 20032.7 20452.7 20733.6 21127.6 21265.8 20437.7 20568.5 20697.5 20845.7 21094.9 5261.8 5833.4 6018.7 6088.1 6106.2 5948.8 6026.5 6052.4 6057.2 6059.5 5742.3 5809.8 5896.1 5911.6 5942.8 5640.5 5854.2 5883.1 5952.4 5965.3 5100.7 5137.9 5157.1 5167.6 5181.4 20842.6 26107.3 26512.9 26540.0 26673.5 2238.7 2289.6 2946.9 3101.0 3172.0 14866.8 15371.0 15582.0 16103.4 16148.4 1827.7 1893.7 1933.2 1946.8 1951.6 87330.1 99144.0 115669.0 115885.4 115976.4 10294.6 10522.8 10617.5 10782.6 10877.3 11530.1 13149.9 13152.9 13158.5 13176.1 7312.6 7322.9 7667.7 8067.2 8097.8 8412.8 8441.1 8479.0 8588.6 8597.7 3768.2 3822.4 3831.8 3834.5 3891.6 1645.9 1895.5 1937.4 1946.3 1963.0 842.0 883.4 897.8 915.8 971.3 20638.8 20999.6 21028.9 21096.9 21245.4 924.3 928.7 963.7 970.3 1017.3 10791.9 11088.1 11093.3 11097.8 11110.8 546796.0 574246.0 579874.0 582878.0 587741.0 90176.0 120078.4 134462.0 138438.0 140917.0 758.5 996.3 1010.9 1014.6 1016.2 18196.9 18586.2 19458.7 19473.3 19580.9 54820.2 55243.0 57313.7 58533.0 58875.4 79015.6 79628.2 83185.6 85043.6 86935.6 6219.4 7643.6 7821.6 7972.9 8123.8 12309.3 12689.5 13126.9 13132.6 13283.7 10769.1 11024.6 11048.5 11264.2 11354.1 10641.5 10884.7 10959.5 11003.3 11120.2 10837.6 11148.0 11268.5 11301.1 11562.5 7845.8 7908.7 7989.6 8032.5 8120.6 10604.2 10839.2 10920.9 11043.6 11288.4 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5636.19 Median:5075.61 stddev:3160.38 (62.3%) stddev-sans-first:3154.16 11:11:10 INFO - PROCESS | 1645 | Values: 1527.4 1555.4 1560.1 1777.7 1940.1 6251.4 7888.5 8577.4 9029.1 9041.9 8643.7 8811.5 8813.3 8828.8 8833.0 1859.9 1898.0 2355.6 2395.9 2401.3 2309.6 2343.1 2398.2 2412.6 2413.0 2383.8 2385.2 2390.9 2407.5 2422.6 2370.3 2379.3 2392.0 2396.2 2407.7 2350.4 2379.0 2381.8 2383.0 2386.5 8923.5 8981.6 8989.1 8996.2 9011.7 5187.9 5258.2 5287.6 5362.7 5367.4 3455.0 3585.5 3620.3 3659.7 3670.7 1066.1 1099.6 1109.9 1124.1 1124.5 11581.4 11659.4 11686.4 11691.9 11695.7 4519.5 4585.6 4795.7 4799.7 4807.2 9840.7 9958.5 9980.2 9982.0 10006.4 5331.3 5342.1 5356.4 5359.1 5363.5 4410.7 4688.8 4858.4 4913.9 4921.0 3923.8 3975.7 4062.8 4078.1 4103.4 1305.3 1308.8 1313.8 1316.6 1329.1 902.7 904.4 920.6 941.8 946.1 5704.1 6008.4 6020.1 6182.9 6208.8 436.1 446.3 449.6 449.9 453.4 3934.2 3978.2 4080.3 4087.2 4102.1 8016.4 10516.7 10621.1 10638.5 10646.6 10288.5 10618.4 10625.9 10635.8 10655.2 8020.6 8121.4 8171.8 8215.3 8237.5 5714.7 5810.3 5813.8 5846.7 5868.9 9809.2 9834.3 9874.9 9898.3 9900.4 8630.6 9034.3 9890.3 9908.4 10016.8 6969.1 7369.7 7399.9 7590.5 7597.9 8312.8 8447.5 8460.2 8465.5 8471.7 7346.1 7409.1 7493.0 7582.8 7604.5 6556.4 7313.0 7458.8 7544.3 7558.8 5392.4 5559.0 6364.8 6656.3 6923.3 3871.3 4893.9 5067.5 5153.0 5166.7 4083.4 4646.2 5083.7 5096.1 5148.9 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4725.11 Median:5108.95 stddev:1509.48 (29.5%) stddev-sans-first:1476.65 11:11:10 INFO - PROCESS | 1645 | Values: 295.8 298.5 299.5 307.9 310.0 4343.8 5465.7 5570.4 5811.0 5822.4 5395.7 5659.5 5737.4 5757.4 5793.9 3747.4 4394.1 4405.0 4405.1 4419.6 3480.4 3643.9 3885.0 4303.2 4436.6 4186.9 4207.2 4214.9 4250.1 4266.6 3858.6 4103.2 4266.3 4269.1 4293.7 2865.4 3626.5 3632.6 3655.4 3671.6 4667.9 5564.9 5570.2 5587.4 5624.5 4067.4 4835.0 4888.0 4897.6 4913.3 5653.4 5897.8 5960.0 5973.3 6025.0 3299.6 3966.8 4004.3 4012.0 4016.6 6038.8 6217.9 6366.5 6423.0 6449.6 3693.0 4041.5 4057.7 4087.8 4093.5 4142.7 4145.2 4152.4 4153.4 4158.1 4823.5 4852.9 4877.5 4893.7 4900.8 4693.8 5061.6 5146.4 5355.0 6036.4 1332.9 1416.6 1435.3 1448.6 1467.6 763.9 775.5 841.9 885.8 908.5 3927.7 4113.9 4440.7 4679.8 4753.6 4299.5 4655.4 4671.1 5195.8 5198.5 4260.8 4598.8 4767.9 4782.6 4827.7 3002.4 3256.0 3256.2 3304.7 3313.8 5701.6 5738.3 6219.8 6257.4 6554.0 5347.7 5559.4 5982.8 6388.5 6444.2 6511.2 6517.6 6523.6 6535.4 6545.6 5084.4 5160.2 6239.5 6248.9 6275.3 5029.8 5133.5 5612.8 5946.5 6160.3 6118.3 6440.5 6533.2 6585.0 6590.9 3349.9 3468.6 3540.0 3815.1 3949.8 5870.9 6186.6 6230.3 6242.3 6294.4 4951.5 5267.5 5347.5 5493.5 5719.8 5478.9 5809.5 5917.7 6067.4 6128.9 5337.9 5535.0 5932.4 5963.3 6009.8 6090.3 6117.1 6128.7 6136.4 6182.9 4566.6 5588.5 5655.8 5952.3 5978.5 11:11:10 INFO - PROCESS | 1645 | 11:11:10 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:24205.45 Median:3689.12 stddev:38328.78 (1039.0%) stddev-sans-first:38395.38 11:11:10 INFO - PROCESS | 1645 | Values: 618.0 682.3 690.5 714.1 724.8 15164.6 15657.0 15846.7 15950.8 15976.4 14763.5 14859.6 14870.5 14897.0 14899.3 664.7 818.1 833.2 834.0 834.8 816.4 835.7 848.0 849.0 849.5 863.3 879.5 884.7 886.8 887.6 868.9 877.0 877.6 877.7 881.2 549.5 632.7 635.6 653.2 655.4 14873.9 15115.0 15198.9 15210.2 15252.2 11563.3 14582.3 14598.7 14648.4 14958.1 11705.2 11867.6 11876.6 11881.0 11894.3 3689.5 3693.9 3700.5 3718.9 3852.0 122760.0 126550.0 127706.1 128237.0 130729.0 9668.9 11013.2 11188.0 11321.1 11638.3 22580.3 22675.9 22699.8 22713.4 22720.4 7501.4 7527.0 7808.0 7959.5 7959.5 4281.1 4326.6 4376.3 4380.8 4419.7 2862.0 3676.4 3679.0 3679.4 3688.8 558.5 633.1 672.5 673.5 714.8 618.6 649.0 650.0 655.4 662.3 9262.4 9478.9 9533.7 9560.6 9702.7 521.2 612.9 628.7 677.3 689.0 4033.4 4124.1 4491.7 4611.7 4715.6 125326.0 143743.0 145106.0 147496.0 148584.0 96158.6 110560.4 110691.0 111971.0 123057.0 103149.5 103746.5 107038.5 107140.0 107436.0 9199.2 9204.2 9872.7 9962.8 9974.6 48759.0 59731.4 62223.0 63073.7 65115.0 59739.0 67706.0 91319.5 95524.0 98241.5 12811.8 12835.9 12993.5 13062.9 13071.2 14238.6 14611.6 14625.1 14654.6 14915.0 13498.8 13577.3 13638.7 13777.4 13815.0 11309.7 13398.8 13768.4 14010.3 14201.2 12278.2 12808.4 12814.7 13001.4 13004.6 11370.7 11468.7 11492.6 11593.5 11619.2 7207.5 9087.6 10450.6 11677.5 11693.2 11:11:10 INFO - PROCESS | 1645 | -------- Summary: end -------- 11:11:10 INFO - PROCESS | 1645 | 11:11:11 INFO - TEST-INFO | 1645: exit 0 11:11:11 INFO - TEST-OK | dromaeo_css | took 1113655ms 11:11:11 INFO - TEST-START | kraken 11:11:11 INFO - operating with platform_type : mac_ 11:11:11 INFO - Initialising browser for kraken test... 11:11:11 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpVF_dpE/profile http://localhost:49262/getInfo.html) 11:11:14 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 11:11:14 INFO - PROCESS | 1658 | colorDepth:24 11:11:14 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 11:11:14 INFO - PROCESS | 1658 | __metrics 11:11:14 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 11:11:15 INFO - TEST-INFO | 1658: exit 0 11:11:15 INFO - Browser initialized. 11:11:15 INFO - Running cycle 1/1 for kraken test... 11:11:15 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpVF_dpE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:27 INFO - PROCESS | 1660 | RSS: Main: 244043776 11:11:27 INFO - PROCESS | 1660 | 11:11:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:30 INFO - PROCESS | 1660 | RSS: Main: 256905216 11:11:30 INFO - PROCESS | 1660 | 11:11:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 11:11:34 INFO - PROCESS | 1660 | RSS: Main: 265560064 11:11:34 INFO - PROCESS | 1660 | 11:11:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 11:11:38 INFO - PROCESS | 1660 | RSS: Main: 264257536 11:11:38 INFO - PROCESS | 1660 | 11:11:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 11:11:40 INFO - PROCESS | 1660 | RSS: Main: 266600448 11:11:40 INFO - PROCESS | 1660 | 11:11:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:43 INFO - PROCESS | 1660 | RSS: Main: 267190272 11:11:43 INFO - PROCESS | 1660 | 11:11:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 11:11:46 INFO - PROCESS | 1660 | RSS: Main: 267235328 11:11:46 INFO - PROCESS | 1660 | 11:11:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:50 INFO - PROCESS | 1660 | RSS: Main: 267497472 11:11:50 INFO - PROCESS | 1660 | 11:11:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 11:11:54 INFO - PROCESS | 1660 | RSS: Main: 267706368 11:11:54 INFO - PROCESS | 1660 | 11:11:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:56 INFO - PROCESS | 1660 | RSS: Main: 267464704 11:11:56 INFO - PROCESS | 1660 | 11:11:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:59 INFO - PROCESS | 1660 | RSS: Main: 267468800 11:11:59 INFO - PROCESS | 1660 | 11:12:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:02 INFO - PROCESS | 1660 | RSS: Main: 267542528 11:12:02 INFO - PROCESS | 1660 | 11:12:05 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:06 INFO - PROCESS | 1660 | RSS: Main: 267603968 11:12:06 INFO - PROCESS | 1660 | 11:12:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:09 INFO - PROCESS | 1660 | RSS: Main: 267780096 11:12:09 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 11:12:11 INFO - PROCESS | 1660 | RSS: Main: 269783040 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | __start_tp_report 11:12:11 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 11:12:11 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 11:12:11 INFO - PROCESS | 1660 | |i|pagename|runs| 11:12:11 INFO - PROCESS | 1660 | |0;ai-astar;107;126;117;114;116;117;118;117;116;133 11:12:11 INFO - PROCESS | 1660 | |1;audio-beat-detection;144;112;138;166;141;133;127;132;164;143 11:12:11 INFO - PROCESS | 1660 | |2;audio-dft;199;206;234;272;242;188;198;199;197;193 11:12:11 INFO - PROCESS | 1660 | |3;audio-fft;72;84;77;145;58;58;58;65;134;61 11:12:11 INFO - PROCESS | 1660 | |4;audio-oscillator;68;71;118;73;68;90;110;69;92;147 11:12:11 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;93;89;93;75;97;76;136;130;93;90 11:12:11 INFO - PROCESS | 1660 | |6;imaging-darkroom;93;143;108;107;99;131;101;135;149;103 11:12:11 INFO - PROCESS | 1660 | |7;imaging-desaturate;98;91;78;148;144;91;93;92;92;92 11:12:11 INFO - PROCESS | 1660 | |8;json-parse-financial;56;62;59;60;72;89;89;82;59;59 11:12:11 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;76;82;61;91;111;79;65;87;103;60 11:12:11 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;87;86;86;90;88;110;111;84;85;90 11:12:11 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;142;139;139;155;163;141;142;180;204;171 11:12:11 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;157;215;210;197;161;156;219;235;176;240 11:12:11 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;68;68;65;61;61;68;70;66;69;66 11:12:11 INFO - PROCESS | 1660 | __end_tp_report 11:12:11 INFO - PROCESS | 1660 | __start_cc_report 11:12:11 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,978 11:12:11 INFO - PROCESS | 1660 | __end_cc_report 11:12:11 INFO - PROCESS | 1660 | __startTimestamp1472667131755__endTimestamp 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | ------- Summary: start ------- 11:12:11 INFO - PROCESS | 1660 | Number of tests: 14 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:118.10 Median:117.00 stddev:6.97 (6.0%) stddev-sans-first:6.12 11:12:11 INFO - PROCESS | 1660 | Values: 107.0 126.0 117.0 114.0 116.0 117.0 118.0 117.0 116.0 133.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:142.00 stddev:16.15 (11.4%) stddev-sans-first:17.07 11:12:11 INFO - PROCESS | 1660 | Values: 144.0 112.0 138.0 166.0 141.0 133.0 127.0 132.0 164.0 143.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:212.80 Median:202.50 stddev:27.30 (13.5%) stddev-sans-first:28.50 11:12:11 INFO - PROCESS | 1660 | Values: 199.0 206.0 234.0 272.0 242.0 188.0 198.0 199.0 197.0 193.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:81.20 Median:63.00 stddev:32.07 (50.9%) stddev-sans-first:33.84 11:12:11 INFO - PROCESS | 1660 | Values: 72.0 84.0 77.0 145.0 58.0 58.0 58.0 65.0 134.0 61.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:70.00 stddev:26.86 (38.4%) stddev-sans-first:27.21 11:12:11 INFO - PROCESS | 1660 | Values: 68.0 71.0 118.0 73.0 68.0 90.0 110.0 69.0 92.0 147.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:97.20 Median:91.50 stddev:20.26 (22.1%) stddev-sans-first:21.44 11:12:11 INFO - PROCESS | 1660 | Values: 93.0 89.0 93.0 75.0 97.0 76.0 136.0 130.0 93.0 90.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:116.90 Median:139.00 stddev:20.42 (14.7%) stddev-sans-first:19.74 11:12:11 INFO - PROCESS | 1660 | Values: 93.0 143.0 108.0 107.0 99.0 131.0 101.0 135.0 149.0 103.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:92.00 stddev:23.79 (25.9%) stddev-sans-first:25.19 11:12:11 INFO - PROCESS | 1660 | Values: 98.0 91.0 78.0 148.0 144.0 91.0 93.0 92.0 92.0 92.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:67.00 stddev:13.23 (19.8%) stddev-sans-first:13.21 11:12:11 INFO - PROCESS | 1660 | Values: 56.0 62.0 59.0 60.0 72.0 89.0 89.0 82.0 59.0 59.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:81.50 Median:77.50 stddev:17.14 (22.1%) stddev-sans-first:18.07 11:12:11 INFO - PROCESS | 1660 | Values: 76.0 82.0 61.0 91.0 111.0 79.0 65.0 87.0 103.0 60.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:86.50 stddev:10.10 (11.7%) stddev-sans-first:10.57 11:12:11 INFO - PROCESS | 1660 | Values: 87.0 86.0 86.0 90.0 88.0 110.0 111.0 84.0 85.0 90.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:157.60 Median:159.00 stddev:21.92 (13.8%) stddev-sans-first:22.51 11:12:11 INFO - PROCESS | 1660 | Values: 142.0 139.0 139.0 155.0 163.0 141.0 142.0 180.0 204.0 171.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.60 Median:212.50 stddev:32.12 (15.1%) stddev-sans-first:30.71 11:12:11 INFO - PROCESS | 1660 | Values: 157.0 215.0 210.0 197.0 161.0 156.0 219.0 235.0 176.0 240.0 11:12:11 INFO - PROCESS | 1660 | 11:12:11 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:68.00 stddev:3.12 (4.6%) stddev-sans-first:3.24 11:12:11 INFO - PROCESS | 1660 | Values: 68.0 68.0 65.0 61.0 61.0 68.0 70.0 66.0 69.0 66.0 11:12:11 INFO - PROCESS | 1660 | -------- Summary: end -------- 11:12:11 INFO - PROCESS | 1660 | 11:12:12 INFO - TEST-INFO | 1660: exit 0 11:12:12 INFO - TEST-OK | kraken | took 60973ms 11:12:12 INFO - SUITE-END | took 1174s 11:12:12 INFO - Completed test suite (00:19:34) 11:12:12 INFO - javascript benchmark 11:12:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7334.23510913983, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2801.285672153601, 3399.898003059909, 3411.982940085299, 3439.501272315514, 3479.338925604136, 5692.829215123543, 5695.829125126248, 5700.572457065721, 5760.36635970044, 5854.356020837705, 5570.108782594785, 5702.258706368177, 5705.74324155413, 5776.59563830531, 5835.941640583593, 5169.974150129254, 5211.609129315298, 5271.947280527184, 5327.961047595721, 5344.011357898782, 5195.714235717034, 5395.271638328834, 5399.78400863965, 5400.891982160354, 5411.972940135313, 4345.500267469234, 4732.195526760459, 4808.807647694088, 5116.948830511685, 5206.297149884755, 5220.451852555465, 5236.659617124875, 5267.3942496613, 5271.894562108736, 5299.49654782795, 5179.948200517984, 5190.091733946544, 5191.480851914816, 5191.974040129775, 5244.134717771563, 5569.164625306196, 5655.632383895075, 5692.829215123553, 5693.829185124453, 5719.799807006776, 6082.935486289882, 6124.2650881894015, 6202.658853763041, 6209.5342849286035, 6218.968905155445, 4628.935344870699, 5366.034113859504, 5832.883342333172, 6128.785492507741, 6346.460550853183, 5709.286339207599, 5754.338251101177, 5761.8559536011935, 5829.912551311733, 5832.766689332421, 5259.263703081571, 6310.968445157745, 6313.9368606314265, 6318.399752023551, 6356.523260755462, 6173.96913015441, 6190.0, 6210.658413787195, 6212.72042758077, 6225.657588832658, 6163.630182189083, 6194.442500174916, 6238.781642642486, 6242.812715618538, 6255.562110652301, 6070.9679354509835, 6106.491003209229, 6168.352323006109, 6181.350958149419, 6212.316645169028, 6087.1173679816175, 6160.507159427235, 6209.627422354673, 6234.251889773256, 6243.469305109026, 4807.4471435784635, 4953.925691114636, 4964.851054468371, 4974.37820272466, 4989.376327959005, 4388.9247134451625, 4395.7142785718825, 4412.271975124133, 4444.555544445529, 4458.175237581057, 5781.4507621775865, 5879.0, 5888.293404791367, 5902.852428689232, 5908.409159084057, 6109.327973922954, 6285.402886725754, 6296.150019747367, 6311.652859092702, 6313.147725057151, 5772.5670574707065, 5843.5325173985975, 5891.116332550152, 5898.439648233411, 5931.40685931412, 5401.270828438111, 5418.512333889968, 5424.674519528841, 5432.701201433959, 5447.700376479253, 6224.937750622617, 6432.163818703539, 6442.16251887261, 6444.452221561032, 6458.06358078076, 6221.875562488815, 6242.063690446469, 6243.625382477066, 6282.057691346335, 6301.527385446201, 6399.168108145911, 6416.48668106541, 6434.356564343529, 6442.549021568632, 6449.032645103272, 6065.787697430569, 6215.254169499689, 6288.11966324724, 6292.590981586182, 6307.180066591313, 6095.075643002825, 6155.815325540241, 6214.720337584729, 6280.466160376419, 6324.083007963912, 6122.448979591858, 6125.571210015256, 6183.659898705614, 6193.81418557444, 6207.0, 5934.19888315072, 6197.442230199304, 6201.1628430163155, 6215.81352559424, 6215.906761398673, 5958.1360702697, 5992.490638295793, 6025.6083354581815, 6052.425019623129, 6110.7250173741395, 6148.282097649322, 6194.34959329282, 6197.225346831646, 6210.3168651449205, 6215.906761398493, 5872.354041055566, 6021.677238899051, 6063.969680151571, 6088.969555152373, 6128.9693551531955], "value": 5705.224225440436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.2580013878558, 512.4363200479473, 529.6689569019363, 533.7864854058377, 551.2998491915265, 37032.44451333229, 40547.59452405479, 40694.38958415626, 40749.59250407495, 40779.79610101953, 41629.375559366556, 42151.789241053826, 42284.73145805623, 42300.0, 42337.0, 9102.681406150787, 9602.375845570034, 9773.609055637766, 9778.804423911517, 9802.41185528867, 7505.136909255423, 7848.332891704212, 8525.31797456202, 9019.864702029476, 9765.414075155479, 9401.153896149344, 9633.470159141245, 9675.742153520032, 9764.755881102994, 9800.36297640651, 8411.579421028955, 9651.034896510328, 9708.708738737849, 9761.804763904682, 9779.364341317792, 9438.433693978383, 9520.143187113194, 9617.27870409715, 9623.133917947349, 9624.711258662252, 39934.201315973514, 39941.0, 40035.59964400348, 40115.0, 40354.0, 3291.670832916713, 3298.967010329914, 3316.2372654289647, 3368.292658541709, 3847.769133851978, 30085.548716769266, 30457.39085218283, 30618.846905765553, 30650.33493965122, 30746.077617671282, 3185.2514659055105, 3185.9203519911957, 3205.743540516776, 3250.5774249347432, 3320.3193345364384, 404772.0, 465838.67080664716, 481558.0, 482740.0, 487706.56146719394, 59581.65856780054, 59825.0, 60222.698886506165, 60301.0, 60382.39617603768, 33500.49749253763, 34339.0, 34614.653853461146, 60055.699721501114, 60294.69852650708, 14185.858141418454, 16606.50180494587, 16627.667446650998, 16631.085290308907, 16669.999800011796, 12739.936300318439, 12819.743605127846, 12837.48650054006, 12841.614751557468, 12856.742865142645, 18939.43181704551, 18966.146523406478, 19211.90394048021, 19215.03924803754, 19219.51951201231, 7801.0, 7919.406044546682, 7923.247291507298, 7965.809402414382, 7974.966383572152, 864.8411129087053, 872.0, 919.8160367926441, 986.7732514677109, 1053.8524606555088, 21631.0, 27250.5912411314, 29666.0, 29861.40277194444, 30144.944926927892, 925.1534845616186, 976.3263348289657, 1042.3693665332517, 1053.3732429204765, 1083.8970297821695, 13022.869771302356, 15121.0, 15535.45625903088, 15706.136162511171, 15810.36758529669, 677232.6138369277, 686250.0, 686486.0, 687530.0, 687830.0, 58434.707826460595, 58492.70753646205, 58760.706196468745, 58868.705656471444, 58952.0, 1265.8544017663844, 1330.940107695156, 1356.1659579358623, 1391.596437033249, 1402.2918426194706, 22087.779122209216, 23846.642300365856, 25512.617310740727, 25844.741552584233, 30160.5475917857, 36052.63947360598, 49764.75117624389, 50334.0, 50473.0, 50577.74711126568, 610045.9497702483, 612043.9397802983, 613633.0, 613640.3179840901, 614723.0, 23785.881070594536, 26205.0, 26454.0, 26568.0, 26575.468490630465, 36633.816830915675, 42769.0, 43652.781736091114, 44768.328475073555, 47658.523414766794, 38748.80625596854, 38796.286160674885, 38912.0, 39833.80083099566, 40755.0, 38415.423768644054, 38426.42360364541, 38675.226495470495, 39745.0, 39976.200475990896, 28436.0, 37715.245695086494, 37925.862224132215, 38159.0, 38261.617383825804, 32066.679333207303, 32933.67066329402, 34346.87837459521, 34939.65060349364, 35073.64926350704, 25072.74927250704, 25170.24489265325, 25246.747532525176, 25257.242282731546, 25901.870490647427], "value": 19514.30427822533, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.7231353349652, 364.9142451523893, 367.3076251266363, 381.1006025779159, 399.3410872061099, 20032.69950950735, 20452.693209601868, 20733.585328293426, 21127.577448451022, 21265.787342126576, 20437.693434598492, 20568.485787855312, 20697.482562935933, 20845.68731469029, 21094.94525273734, 5261.842144735664, 5833.358330583633, 6018.6689732064715, 6088.117223002662, 6106.236720409949, 5948.821535353946, 6026.4576188143055, 6052.425019623129, 6057.212562366886, 6059.515238780887, 5742.339630942432, 5809.7676092956235, 5896.056630939051, 5911.556633252501, 5942.821715348547, 5640.492355687967, 5854.2389489366105, 5883.058710606304, 5952.404759524056, 5965.284165900098, 5100.744962751847, 5137.897242055175, 5157.149070403379, 5167.586593072545, 5181.35233095863, 20842.583148336947, 26107.347316317053, 26512.93948242068, 26540.0, 26673.466530669277, 2238.6530087836413, 2289.645105008726, 2946.9096434319226, 3100.9844950775328, 3172.0483854843687, 14866.776998345034, 15371.0, 15581.98717083386, 16103.43637972677, 16148.354065837353, 1827.6527459782599, 1893.697008478637, 1933.168737442899, 1946.7566554180728, 1951.6389467948475, 87330.12669873284, 99144.0, 115669.0, 115885.42057289743, 115976.42011789887, 10294.639687610897, 10522.842157367646, 10617.469126543641, 10782.622608208674, 10877.347359158475, 11530.135239857043, 13149.934250328688, 13152.934235328954, 13158.539451119164, 13176.143550669176, 7312.561246325131, 7322.864955931839, 7667.702887758317, 8067.233612806891, 8097.757067287991, 8412.8317433651, 8441.07148213696, 8479.0, 8588.613512391958, 8597.656093756179, 3768.171002379472, 3822.3884178531857, 3831.7700937943814, 3834.5206849143856, 3891.610838916086, 1645.8930169538942, 1895.4692686047654, 1937.428458604715, 1946.2604210399957, 1962.9901850490655, 841.9915800841914, 883.430187529053, 897.7620930453435, 915.7527467583715, 971.2618410008445, 20638.793612063986, 20999.580008399746, 21028.894855525625, 21096.894515527325, 21245.362639120853, 924.2698268367914, 928.7445952363154, 963.6579014449909, 970.3062310448064, 1017.2675673515057, 10791.892081079246, 11088.057515111306, 11093.278936869077, 11097.83353249702, 11110.833337499944, 546796.0, 574246.0, 579874.0, 582878.0, 587741.0, 90176.0, 120078.3996080014, 134462.0, 138438.0, 140917.0, 758.4880205861022, 996.3175224970918, 1010.9191264698953, 1014.5535964175739, 1016.242899040205, 18196.90901545484, 18586.163622636745, 19458.708119377938, 19473.318433854747, 19580.902095489433, 54820.17769733378, 55243.0, 57313.713431432574, 58533.0, 58875.41124588699, 79015.60492197503, 79628.2037179644, 83185.58407207925, 85043.5747821257, 86935.56532217299, 6219.40915613016, 7643.617819109134, 7821.569813660303, 7972.920270797218, 8123.83752324962, 12309.26144431337, 12689.492420303084, 13126.934365328112, 13132.606021819362, 13283.66790830237, 10769.13846892231, 11024.559017639205, 11048.502817373077, 11264.155188360743, 11354.091672666333, 10641.467926603484, 10884.727881803019, 10959.50682219318, 11003.304190473385, 11120.165987550805, 10837.620683276047, 11148.0, 11268.549258029587, 11301.09591232683, 11562.47968841421, 7845.843083138419, 7908.683652654059, 7989.640466178919, 8032.518048917083, 8120.634571444181, 10604.151667866397, 10839.187060970302, 10920.945395272973, 11043.625620491634, 11288.379139147426], "value": 9566.764754080898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.3814105287363, 1555.4400415850284, 1560.0951448160067, 1777.7066783980645, 1940.1463356123295, 6251.374862513746, 7888.487248328855, 8577.356698247626, 9029.097090290976, 9041.914970203576, 8643.697470588531, 8811.471311721301, 8813.294936405087, 8828.77928051799, 8832.955835220815, 1859.9398342944528, 1898.0320036781202, 2355.5877721398774, 2395.9041638334534, 2401.3396316013063, 2309.6304591265402, 2343.144752165456, 2398.2085911649115, 2412.601920683085, 2413.046846495642, 2383.797377222938, 2385.2367242482414, 2390.916317928873, 2407.5425669122897, 2422.6244932035474, 2370.2889133259955, 2379.3218932604213, 2392.031227352925, 2396.173320204544, 2407.7471865454136, 2350.4476448034698, 2379.0127097254617, 2381.809095452274, 2383.0467812874817, 2386.4869053153657, 8923.464592124428, 8981.640734370618, 8989.101089891024, 8996.190342869108, 9011.729648110568, 5187.922181167285, 5258.211268309746, 5287.629865909388, 5362.6782393056155, 5367.382750983609, 3454.9654503454894, 3585.533880595532, 3620.275944811022, 3659.670629643345, 3670.7063434925144, 1066.072516910293, 1099.6151347028476, 1109.8945600167972, 1124.0670243697712, 1124.5333186727498, 11581.42092895352, 11659.358735269558, 11686.415679216005, 11691.883081169164, 11695.7076073098, 4519.480259770168, 4585.564371384713, 4795.664303498722, 4799.712017278975, 4807.18277892759, 9840.704778856645, 9958.502074896227, 9980.201583873273, 9981.950090249502, 10006.399616022916, 5331.253624492574, 5342.1185504392115, 5356.437574054746, 5359.115745901882, 5363.463653634605, 4410.735355878657, 4688.765561721901, 4858.416989961157, 4913.877153071202, 4921.0, 3923.803809809498, 3975.7018223633345, 4062.7968601569805, 4078.1435898461655, 4103.363978583325, 1305.2951406240713, 1308.7905935050346, 1313.8423389193358, 1316.5786948176492, 1329.0895736420582, 902.7427183252742, 904.380499357942, 920.6087412849512, 941.8180183869338, 946.0775743649887, 5704.087346024616, 6008.429199226067, 6020.096985452217, 6182.938170618237, 6208.81373558794, 436.12121575026345, 446.28371463800136, 449.5616773645735, 449.93925820014533, 453.37887094680497, 3934.2131573684806, 3978.224246272007, 4080.2859499587453, 4087.2234275487563, 4102.097538541516, 8016.358691304798, 10516.68449946503, 10621.097206737359, 10638.468076596138, 10646.574137034588, 10288.485575721184, 10618.362898225976, 10625.946870265754, 10635.840462393071, 10655.200859935536, 8020.639071241808, 8121.431499794958, 8171.836563268701, 8215.260626543639, 8237.46456480327, 5714.714264286852, 5810.273715785527, 5813.82558523245, 5846.6784326862435, 5868.853278668067, 9809.215262778818, 9834.262430317898, 9874.85187722199, 9898.307118501923, 9900.356476828983, 8630.56847157627, 9034.322425817958, 9890.307678462439, 9908.388504475892, 10016.799664006534, 6969.128858892638, 7369.668364923484, 7399.889001665087, 7590.544567325978, 7597.924020759942, 8312.833743324978, 8447.493150410995, 8460.196281353261, 8465.534395608302, 8471.745847624581, 7346.081739782528, 7409.147947985835, 7493.0, 7582.772516824504, 7604.505707129019, 6556.377144171296, 7312.96343518279, 7458.776236712907, 7544.283293087148, 7558.773236802905, 5392.379876314274, 5558.999380111457, 6364.77723279683, 6656.267810540933, 6923.273056329214, 3871.3418718817306, 4893.947801222755, 5067.5185857343495, 5152.995165942605, 5166.689998600096, 4083.3670781028986, 4646.163690535736, 5083.694978301313, 5096.108181068373, 5148.922766158586], "value": 4477.35835917095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.7811219697424, 298.47170508200475, 299.51628120585264, 307.8722330232953, 309.97707565035375, 4343.782810859456, 5465.672059676423, 5570.442955704428, 5810.970945145279, 5822.359540450552, 5395.7032363220105, 5659.462351076651, 5737.397573254811, 5757.42425757424, 5793.913091303634, 3747.3816820224765, 4394.055278115213, 4405.00887300358, 4405.05291362357, 4419.558044195571, 3480.4257297545873, 3643.9453408198765, 3884.961150388502, 4303.225419424502, 4436.645068394537, 4186.874393768192, 4207.169881101715, 4214.936775948363, 4250.129942825162, 4266.57334266574, 3858.6334298241763, 4103.2409004333995, 4266.338717498793, 4269.103488267468, 4293.699441039129, 2865.3839424523826, 3626.4741612466046, 3632.6367363263726, 3655.3785856404475, 3671.6328367163337, 4667.929981050287, 5564.944350556483, 5570.2480165177585, 5587.368210663061, 5624.493795558378, 4067.4102255172834, 4834.975825120887, 4888.0, 4897.559219670246, 4913.31213630092, 5653.434656534355, 5897.764089436418, 5960.0, 5973.253343332083, 6025.0, 3299.6040475143136, 3966.7818269995137, 4004.2592120457516, 4011.9799401002806, 4016.5581786003518, 6038.818835434944, 6217.906731399033, 6366.458850997671, 6422.967885160544, 6449.645269510175, 3692.9815350923072, 4041.535223449341, 4057.6753859691153, 4087.7751723655483, 4093.508778946486, 4142.689298302639, 4145.150244199932, 4152.397902304149, 4153.439285696392, 4158.147579746144, 4823.541763532458, 4852.878678033077, 4877.463479017305, 4893.681910675866, 4900.803967841246, 4693.812247510062, 5061.5950723942, 5146.371807875439, 5354.955783622157, 6036.426539478743, 1332.886704630098, 1416.6458385403648, 1435.2608406670572, 1448.6233579269256, 1467.5817392043216, 763.86184584968, 775.4571799740091, 841.9181351962699, 885.7953183670203, 908.5230254116509, 3927.66614837742, 4113.8529025295675, 4440.666949978765, 4679.836205732851, 4753.643476739189, 4299.505556861001, 4655.44134703831, 4671.131547381006, 5195.818146364934, 5198.532132108053, 4260.808263628144, 4598.804310879195, 4767.928481072718, 4782.593479554277, 4827.710337379768, 3002.3544937838033, 3255.9650218613365, 3256.234784825564, 3304.653011433813, 3313.8177400243217, 5701.600887937888, 5738.340090889517, 6219.751209951642, 6257.374262573706, 6553.967230163818, 5347.679139251657, 5559.416261292587, 5982.773531426047, 6388.466767975652, 6444.226692796894, 6511.2419646695125, 6517.57635753684, 6523.641199733966, 6535.411812936859, 6545.574537655038, 5084.440711521655, 5160.174372100596, 6239.500839932885, 6248.906266406098, 6275.341089185752, 5029.823956161516, 5133.460986596354, 5612.849365879903, 5946.524278057832, 6160.322364539987, 6118.265808103056, 6440.4525615321345, 6533.18335208099, 6585.0, 6590.934090659032, 3349.916252093717, 3468.635793241673, 3539.9734077117346, 3815.0843797488956, 3949.763014219156, 5870.911936320873, 6186.566940314135, 6230.314665386894, 6242.250929888442, 6294.402031806971, 4951.5048495150195, 5267.525922666979, 5347.51872331492, 5493.450654934634, 5719.799807006735, 5478.945210547843, 5809.477147056785, 5917.674527900835, 6067.393260673897, 6128.938710613015, 5337.946620533745, 5534.972325138348, 5932.377100404396, 5963.344032156372, 6009.806420656516, 6090.299615544269, 6117.143599896107, 6128.74052533485, 6136.447719705248, 6182.938170618416, 4566.634669226521, 5588.497035266845, 5655.830325090254, 5952.315483719254, 5978.491828194478], "value": 4238.775678071996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.9969100154499, 682.2938258902037, 690.4924880213046, 714.0574441736906, 724.7572063358774, 15164.62088447788, 15657.0, 15846.683066338666, 15950.76073858893, 15976.440824571142, 14763.483278085243, 14859.628509287273, 14870.47953321634, 14897.0, 14899.25503724815, 664.7042066280507, 818.0510607695089, 833.2167762303416, 834.0200264688997, 834.7954751085992, 816.4244207833493, 835.7242110103651, 848.0374774630777, 848.9812225329598, 849.5200211880268, 863.2964134230614, 879.5074758135432, 884.7080463447079, 886.7738726624701, 887.5917078144062, 868.891388576428, 876.9649214031463, 877.6313948141732, 877.6752601537409, 881.2113158722939, 549.4862303745971, 632.7026297640102, 635.5900444213503, 653.1574269192736, 655.3708439897656, 14873.851261487354, 15115.0, 15198.924005379902, 15210.16344101074, 15252.161131137784, 11563.306201627845, 14582.270886455635, 14598.70802583953, 14648.414063437449, 14958.102513849095, 11705.239159454608, 11867.550989876896, 11876.643700688994, 11881.049516038696, 11894.345810980392, 3689.4834723138783, 3693.8522459101605, 3700.5374328208973, 3718.9442158367647, 3851.961480385188, 122760.0, 126550.0, 127706.08440873395, 128237.0, 130729.0, 9668.888077870994, 11013.229073964905, 11188.0, 11321.094312454983, 11638.301701897914, 22580.322590322317, 22675.886620567122, 22699.773002269765, 22713.432164196027, 22720.43198920007, 7501.362384197404, 7527.0, 7807.960960195162, 7959.482633628795, 7959.482633628912, 4281.100968796525, 4326.58897404746, 4376.321670141069, 4380.773383452638, 4419.668524860648, 2861.957070643942, 3676.356637588411, 3678.9632103679155, 3679.4112941929698, 3688.7602305850032, 558.5085125089976, 633.1452539072216, 672.4553111979312, 673.491513906997, 714.8284411741249, 618.6380967134277, 648.9610623362613, 649.9870002599921, 655.4363247607054, 662.3045801907978, 9262.44425334482, 9478.857817132748, 9533.666321678707, 9560.617575297048, 9702.70891873245, 521.1869483605511, 612.9111278864629, 628.7277946354532, 677.265167293492, 689.007828726632, 4033.4151548025957, 4124.05146816234, 4491.685582009228, 4611.723296602215, 4715.55202255792, 125326.0, 143743.0, 145106.0, 147496.0, 148584.0, 96158.55762163573, 110560.4471977635, 110691.0, 111971.0, 123057.0, 103149.48425257826, 103746.48126759318, 107038.46480767547, 107140.0, 107436.0, 9199.23902623191, 9204.21764150028, 9872.65418879772, 9962.800743984935, 9974.55114519863, 48759.0, 59731.402685972585, 62223.0, 63073.68463157655, 65115.02327464997, 59739.0, 67706.0, 91319.54340228256, 95524.0, 98241.50879245844, 12811.80782288285, 12835.935820321212, 12993.545225917047, 13062.869371306166, 13071.215727056408, 14238.644033898821, 14611.561653150422, 14625.122492650475, 14654.56036318912, 14915.0, 13498.797518037041, 13577.32113394346, 13638.659033524242, 13777.448902044207, 13815.0, 11309.660710178709, 13398.799018014543, 13768.449262029406, 14010.299485025911, 14201.218932958787, 12278.201916875732, 12808.359582020676, 12814.743705126031, 13001.4149363277, 13004.609861704164, 11370.715732106764, 11468.713282168013, 11492.597759078391, 11593.536258549564, 11619.244749091282, 7207.495475316678, 9087.59105840252, 10450.581976720847, 11677.532898683958, 11693.181477296848], "value": 7698.949191559993, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 126.0, 117.0, 114.0, 116.0, 117.0, 118.0, 117.0, 116.0, 133.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 138.0, 166.0, 141.0, 133.0, 127.0, 132.0, 164.0, 143.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 206.0, 234.0, 272.0, 242.0, 188.0, 198.0, 199.0, 197.0, 193.0], "value": 212.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 84.0, 77.0, 145.0, 58.0, 58.0, 58.0, 65.0, 134.0, 61.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 118.0, 73.0, 68.0, 90.0, 110.0, 69.0, 92.0, 147.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 93.0, 75.0, 97.0, 76.0, 136.0, 130.0, 93.0, 90.0], "value": 97.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 143.0, 108.0, 107.0, 99.0, 131.0, 101.0, 135.0, 149.0, 103.0], "value": 116.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 91.0, 78.0, 148.0, 144.0, 91.0, 93.0, 92.0, 92.0, 92.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 62.0, 59.0, 60.0, 72.0, 89.0, 89.0, 82.0, 59.0, 59.0], "value": 68.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 61.0, 91.0, 111.0, 79.0, 65.0, 87.0, 103.0, 60.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 90.0, 88.0, 110.0, 111.0, 84.0, 85.0, 90.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 139.0, 155.0, 163.0, 141.0, 142.0, 180.0, 204.0, 171.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 215.0, 210.0, 197.0, 161.0, 156.0, 219.0, 235.0, 176.0, 240.0], "value": 196.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 65.0, 61.0, 61.0, 68.0, 70.0, 66.0, 69.0, 66.0], "value": 66.2, "unit": "score"}]}]} 11:12:12 INFO - Return code: 0 11:12:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:12:13 ERROR - # TBPL SUCCESS # 11:12:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:13 INFO - 2016-08-31 11:12:13.065 screenresolution[1665:10350] starting screenresolution argv=screenresolution get 11:12:13 INFO - 2016-08-31 11:12:13.067 screenresolution[1665:10350] Display 0: 1600x1200x32@60 11:12:13 INFO - 2016-08-31 11:12:13.073 screenresolution[1666:10353] starting screenresolution argv=screenresolution list 11:12:13 INFO - Available Modes on Display 0 11:12:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:13 INFO - Intel Iris: 11:12:13 INFO - Chipset Model: Intel Iris 11:12:13 INFO - Type: GPU 11:12:13 INFO - Bus: Built-In 11:12:13 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:13 INFO - Vendor: Intel (0x8086) 11:12:13 INFO - Device ID: 0x0a2e 11:12:13 INFO - Revision ID: 0x0009 11:12:13 INFO - Displays: 11:12:13 INFO - Display: 11:12:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:13 INFO - Display Serial Number: 1600x1200 60 11:12:13 INFO - Main Display: Yes 11:12:13 INFO - Mirror: Off 11:12:13 INFO - Online: Yes 11:12:13 INFO - Rotation: Supported 11:12:13 INFO - Return code: 0 11:12:13 INFO - Running post-action listener: _resource_record_post_action 11:12:13 INFO - [mozharness: 2016-08-31 18:12:13.314802Z] Finished run-tests step (success) 11:12:13 INFO - Running post-run listener: _resource_record_post_run 11:12:13 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38573056; Write bytes: 708916736; Read time: 384; Write time: 2291 11:12:13 INFO - TinderboxPrint: CPU usage
54.3% 11:12:13 INFO - TinderboxPrint: I/O read bytes / time
38,573,056 / 384 11:12:13 INFO - TinderboxPrint: I/O write bytes / time
708,916,736 / 2,291 11:12:13 INFO - TinderboxPrint: CPU idle
2,211.5 (45.7%) 11:12:13 INFO - TinderboxPrint: CPU system
977.6 (20.2%) 11:12:13 INFO - TinderboxPrint: CPU user
1,652.6 (34.1%) 11:12:13 INFO - TinderboxPrint: Swap in / out
444,801,024 / 0 11:12:13 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 403057152; Write bytes: 398538752; Read time: 30644; Write time: 785 11:12:13 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36426752; Write bytes: 297635328; Read time: 359; Write time: 1473 11:12:13 INFO - Running post-run listener: _upload_blobber_files 11:12:13 INFO - Blob upload gear active. 11:12:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:15 INFO - (blobuploader) - INFO - Done attempting. 11:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:16 INFO - (blobuploader) - INFO - Done attempting. 11:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:12:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:19 INFO - (blobuploader) - INFO - Done attempting. 11:12:19 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:19 INFO - Return code: 0 11:12:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f14df60cab2b4d0bf07842665b18cf5e098a54279e616099b60f6902c988e29a34586d80014f07c946d8f5d693c03c05860d89a6ba5d61848cc17d23fa319041", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e8b9366112028b5b02e4ba04fcd4019adb467724ef483f26613ef1301c70eab01e701b54609afbc0719d2a8b84696b173eee8a5461f61b85fd875332daaf71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91c1f9917ce58b4f3565cdbcd5ede99f15a28d18c7b3d0548ac800e3edb9926b45c991ba3c7f24ef3d1c470bb38f6545a9ffe07b6abe6514e7cca2b248f86f4c"} 11:12:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:19 INFO - Contents: 11:12:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f14df60cab2b4d0bf07842665b18cf5e098a54279e616099b60f6902c988e29a34586d80014f07c946d8f5d693c03c05860d89a6ba5d61848cc17d23fa319041", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e8b9366112028b5b02e4ba04fcd4019adb467724ef483f26613ef1301c70eab01e701b54609afbc0719d2a8b84696b173eee8a5461f61b85fd875332daaf71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91c1f9917ce58b4f3565cdbcd5ede99f15a28d18c7b3d0548ac800e3edb9926b45c991ba3c7f24ef3d1c470bb38f6545a9ffe07b6abe6514e7cca2b248f86f4c"} 11:12:19 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:19 INFO - Copying logs to upload dir... 11:12:19 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.876014 ========= master_lag: 3.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-31 11:12:23.490124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:12:23.492195) ========= 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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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/f14df60cab2b4d0bf07842665b18cf5e098a54279e616099b60f6902c988e29a34586d80014f07c946d8f5d693c03c05860d89a6ba5d61848cc17d23fa319041", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e8b9366112028b5b02e4ba04fcd4019adb467724ef483f26613ef1301c70eab01e701b54609afbc0719d2a8b84696b173eee8a5461f61b85fd875332daaf71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91c1f9917ce58b4f3565cdbcd5ede99f15a28d18c7b3d0548ac800e3edb9926b45c991ba3c7f24ef3d1c470bb38f6545a9ffe07b6abe6514e7cca2b248f86f4c"} build_url:https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012189 build_url: 'https://queue.taskcluster.net/v1/task/SUwee8Y5R2yAY5Ch_bIidQ/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/f14df60cab2b4d0bf07842665b18cf5e098a54279e616099b60f6902c988e29a34586d80014f07c946d8f5d693c03c05860d89a6ba5d61848cc17d23fa319041", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e8b9366112028b5b02e4ba04fcd4019adb467724ef483f26613ef1301c70eab01e701b54609afbc0719d2a8b84696b173eee8a5461f61b85fd875332daaf71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91c1f9917ce58b4f3565cdbcd5ede99f15a28d18c7b3d0548ac800e3edb9926b45c991ba3c7f24ef3d1c470bb38f6545a9ffe07b6abe6514e7cca2b248f86f4c"}' ========= master_lag: 0.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:12:23.752537) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:12:23.752835) ========= 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.sIZKvhpXRe/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.YFWOfFR6ug/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005304 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:12:23.778370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:12:23.778682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:12:23.780157) ========= ========= Total master_lag: 4.08 =========