builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0075 starttime: 1468633905.88 results: success (0) buildid: 20160715165053 builduid: 92d00abb945d4521b30d20be31ef0929 revision: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:45.876047) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:45.876449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:45.876732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:46.471925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:46.472326) ========= 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.8XSv766oPs/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.cdpjSgt5Kw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-07-15 18:51:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-07-15 18:51:46 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114665 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:46.620776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:46.621101) ========= 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.8XSv766oPs/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.cdpjSgt5Kw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.027929 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:46.669304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 18:51:46.669654) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c --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 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8XSv766oPs/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.cdpjSgt5Kw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-07-15 18:51:46,743 truncating revision to first 12 chars 2016-07-15 18:51:46,743 Setting DEBUG logging. 2016-07-15 18:51:46,743 attempt 1/10 2016-07-15 18:51:46,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0d82d5d030af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 18:51:47,452 unpacking tar archive at: mozilla-central-0d82d5d030af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.995444 ========= master_lag: 0.89 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 18:51:48.558261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:48.558562) ========= script_repo_revision: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:48.558974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:48.559234) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 18:51:48.583808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-15 18:51:48.584185) ========= /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.8XSv766oPs/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.cdpjSgt5Kw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:51:48 INFO - MultiFileLogger online at 20160715 18:51:48 in /builds/slave/test 18:51:48 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 18:51:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:51:48 INFO - {'append_to_log': False, 18:51:48 INFO - 'base_work_dir': '/builds/slave/test', 18:51:48 INFO - 'blob_upload_branch': 'Firefox', 18:51:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:51:48 INFO - 'branch': 'Firefox', 18:51:48 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:48 INFO - 'config_files': ('talos/mac_config.py',), 18:51:48 INFO - 'default_actions': ('clobber', 18:51:48 INFO - 'read-buildbot-config', 18:51:48 INFO - 'download-and-extract', 18:51:48 INFO - 'populate-webroot', 18:51:48 INFO - 'create-virtualenv', 18:51:48 INFO - 'install', 18:51:48 INFO - 'run-tests'), 18:51:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:48 INFO - 'download_minidump_stackwalk': True, 18:51:48 INFO - 'download_symbols': 'ondemand', 18:51:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:51:48 INFO - 'tooltool.py': '/tools/tooltool.py', 18:51:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:51:48 INFO - '/tools/misc-python/virtualenv.py')}, 18:51:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:48 INFO - 'installer_path': 'installer.exe', 18:51:48 INFO - 'log_level': 'info', 18:51:48 INFO - 'log_name': 'talos', 18:51:48 INFO - 'log_to_console': True, 18:51:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:51:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:51:48 INFO - 'opt_config_files': (), 18:51:48 INFO - 'pip_index': False, 18:51:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:51:48 INFO - 'cmd': ('bash', 18:51:48 INFO - '-c', 18:51:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:51:48 INFO - 'enabled': True, 18:51:48 INFO - 'halt_on_failure': False, 18:51:48 INFO - 'name': 'check_screen_resolution'},), 18:51:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:51:48 INFO - 'cmd': ('bash', 18:51:48 INFO - '-c', 18:51:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:51:48 INFO - 'enabled': True, 18:51:48 INFO - 'halt_on_failure': False, 18:51:48 INFO - 'name': 'check_screen_resolution'},), 18:51:48 INFO - 'run_cmd_checks_enabled': True, 18:51:48 INFO - 'sps_profile': False, 18:51:48 INFO - 'sps_profile_interval': 0, 18:51:48 INFO - 'suite': 'dromaeojs-e10s', 18:51:48 INFO - 'system_bits': '32', 18:51:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:48 INFO - 'title': 't-yosemite-r7-0075', 18:51:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:51:48 INFO - 'use_talos_json': True, 18:51:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:51:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:48 INFO - 'work_dir': 'build'} 18:51:48 INFO - ##### 18:51:48 INFO - ##### Running clobber step. 18:51:48 INFO - ##### 18:51:48 INFO - Running pre-action listener: _resource_record_pre_action 18:51:48 INFO - Running main action method: clobber 18:51:48 INFO - rmtree: /builds/slave/test/build 18:51:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:51:50 INFO - Running post-action listener: _resource_record_post_action 18:51:50 INFO - ##### 18:51:50 INFO - ##### Finished clobber step (success) 18:51:50 INFO - ##### 18:51:50 INFO - ##### 18:51:50 INFO - ##### Running read-buildbot-config step. 18:51:50 INFO - ##### 18:51:50 INFO - Running pre-action listener: _resource_record_pre_action 18:51:50 INFO - Running main action method: read_buildbot_config 18:51:50 INFO - Using buildbot properties: 18:51:50 INFO - { 18:51:50 INFO - "project": "", 18:51:50 INFO - "product": "firefox", 18:51:50 INFO - "script_repo_revision": "production", 18:51:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:51:50 INFO - "repository": "", 18:51:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:51:50 INFO - "buildid": "20160715165053", 18:51:50 INFO - "pgo_build": "False", 18:51:50 INFO - "basedir": "/builds/slave/test", 18:51:50 INFO - "buildnumber": 1, 18:51:50 INFO - "slavename": "t-yosemite-r7-0075", 18:51:50 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:51:50 INFO - "platform": "yosemite_r7", 18:51:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:51:50 INFO - "branch": "mozilla-central", 18:51:50 INFO - "repo_path": "mozilla-central", 18:51:50 INFO - "revision": "0d82d5d030afa2e8f48dd68e86eb75efd0947a5c", 18:51:50 INFO - "stage_platform": "macosx64", 18:51:50 INFO - "builduid": "92d00abb945d4521b30d20be31ef0929", 18:51:50 INFO - "slavebuilddir": "test" 18:51:50 INFO - } 18:51:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 18:51:50 INFO - Running post-action listener: _resource_record_post_action 18:51:50 INFO - ##### 18:51:50 INFO - ##### Finished read-buildbot-config step (success) 18:51:50 INFO - ##### 18:51:50 INFO - ##### 18:51:50 INFO - ##### Running download-and-extract step. 18:51:50 INFO - ##### 18:51:50 INFO - Running pre-action listener: _resource_record_pre_action 18:51:50 INFO - Running main action method: download_and_extract 18:51:50 INFO - mkdir: /builds/slave/test/build/tests 18:51:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:50 INFO - https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 18:51:52 INFO - Downloaded 1199 bytes. 18:51:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:51:52 INFO - Using the following test package requirements: 18:51:52 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:51:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 18:51:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 18:51:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'jsshell-mac.zip'], 18:51:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 18:51:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:51:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 18:51:52 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 18:51:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 18:51:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:51:52 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 18:51:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:52 INFO - https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:51:53 INFO - Downloaded 18829405 bytes. 18:51:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:51:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:51:56 INFO - Return code: 0 18:51:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:51:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:56 INFO - https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:51:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:51:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:51:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:51:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:51:57 INFO - Downloaded 18829405 bytes. 18:51:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:51:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:52:01 INFO - Return code: 0 18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:01 INFO - https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:52:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:52:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:52:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:52:02 INFO - Downloaded 14403317 bytes. 18:52:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:52:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:52:02 INFO - Return code: 0 18:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:02 INFO - https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:52:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:52:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:52:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 18:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 18:52:06 INFO - Downloaded 112790159 bytes. 18:52:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:52:06 INFO - mkdir: /builds/slave/test/properties 18:52:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:52:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:52:06 INFO - Contents: 18:52:06 INFO - build_url:https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:52:07 INFO - Running post-action listener: _resource_record_post_action 18:52:07 INFO - Running post-action listener: set_extra_try_arguments 18:52:07 INFO - ##### 18:52:07 INFO - ##### Finished download-and-extract step (success) 18:52:07 INFO - ##### 18:52:07 INFO - ##### 18:52:07 INFO - ##### Running populate-webroot step. 18:52:07 INFO - ##### 18:52:07 INFO - Running pre-action listener: _resource_record_pre_action 18:52:07 INFO - Running main action method: populate_webroot 18:52:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:52:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:52:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:52:07 INFO - '--tppagecycles', 18:52:07 INFO - '7'], 18:52:07 INFO - 'tests': ['tsvgm']}}, 18:52:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:52:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:52:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:52:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:52:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['damp', 'tps']}, 18:52:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'tests': ['damp', 'tps']}, 18:52:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['dromaeo_dom']}, 18:52:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:52:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['basic_compositor_video']}, 18:52:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:52:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['a11yr', 18:52:07 INFO - 'ts_paint', 18:52:07 INFO - 'tpaint', 18:52:07 INFO - 'sessionrestore', 18:52:07 INFO - 'sessionrestore_no_auto_restore', 18:52:07 INFO - 'tabpaint']}, 18:52:07 INFO - 'other-e10s': {'tests': ['a11yr', 18:52:07 INFO - 'ts_paint', 18:52:07 INFO - 'tpaint', 18:52:07 INFO - 'sessionrestore', 18:52:07 INFO - 'sessionrestore_no_auto_restore', 18:52:07 INFO - 'tabpaint']}, 18:52:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:52:07 INFO - 'ts_paint', 18:52:07 INFO - 'tpaint', 18:52:07 INFO - 'sessionrestore', 18:52:07 INFO - 'sessionrestore_no_auto_restore', 18:52:07 INFO - 'tabpaint']}, 18:52:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:52:07 INFO - 'ts_paint', 18:52:07 INFO - 'tpaint', 18:52:07 INFO - 'sessionrestore', 18:52:07 INFO - 'sessionrestore_no_auto_restore', 18:52:07 INFO - 'tabpaint']}, 18:52:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['a11yr', 18:52:07 INFO - 'ts_paint', 18:52:07 INFO - 'tpaint', 18:52:07 INFO - 'sessionrestore', 18:52:07 INFO - 'sessionrestore_no_auto_restore', 18:52:07 INFO - 'tabpaint']}, 18:52:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['a11yr', 18:52:07 INFO - 'ts_paint', 18:52:07 INFO - 'tpaint', 18:52:07 INFO - 'sessionrestore', 18:52:07 INFO - 'sessionrestore_no_auto_restore', 18:52:07 INFO - 'tabpaint']}, 18:52:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['tsvgx', 18:52:07 INFO - 'tsvgr_opacity', 18:52:07 INFO - 'tart', 18:52:07 INFO - 'tscrollx', 18:52:07 INFO - 'cart']}, 18:52:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:52:07 INFO - 'tsvgr_opacity', 18:52:07 INFO - 'tart', 18:52:07 INFO - 'tscrollx', 18:52:07 INFO - 'cart']}, 18:52:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'talos_options': ['--disable-e10s'], 18:52:07 INFO - 'tests': ['tp5o']}, 18:52:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'tests': ['tp5o']}, 18:52:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'talos_options': ['--disable-e10s', 18:52:07 INFO - '--xperf_path', 18:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:07 INFO - 'tests': ['tp5n']}, 18:52:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:52:07 INFO - 'talos_options': ['--xperf_path', 18:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:07 INFO - 'tests': ['tp5n']}}, 18:52:07 INFO - 'talos.zip': {'path': '', 18:52:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:52:07 INFO - Running post-action listener: _resource_record_post_action 18:52:07 INFO - ##### 18:52:07 INFO - ##### Finished populate-webroot step (success) 18:52:07 INFO - ##### 18:52:07 INFO - ##### 18:52:07 INFO - ##### Running create-virtualenv step. 18:52:07 INFO - ##### 18:52:07 INFO - Running pre-action listener: _resource_record_pre_action 18:52:07 INFO - Running main action method: create_virtualenv 18:52:07 INFO - Creating virtualenv /builds/slave/test/build/venv 18:52:08 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 18:52:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:52:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:52:08 INFO - Using real prefix '/tools/python27' 18:52:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:52:08 INFO - Installing distribute.............................................................................................................................................................................................done. 18:52:11 INFO - Installing pip.................done. 18:52:11 INFO - Return code: 0 18:52:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:11 INFO - 'HOME': '/Users/cltbld', 18:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:11 INFO - 'LOGNAME': 'cltbld', 18:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:11 INFO - 'MOZ_NO_REMOTE': '1', 18:52:11 INFO - 'NO_EM_RESTART': '1', 18:52:11 INFO - 'PAGER': '/bin/cat', 18:52:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:11 INFO - 'PWD': '/builds/slave/test', 18:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:11 INFO - 'SHELL': '/bin/bash', 18:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:11 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:11 INFO - 'USER': 'cltbld', 18:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:11 INFO - 'XPC_FLAGS': '0x0', 18:52:11 INFO - 'XPC_SERVICE_NAME': '0', 18:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:11 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 18:52:11 INFO - Cleaning up... 18:52:12 INFO - Return code: 0 18:52:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:52:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:12 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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:12 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 18:52:12 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 18:52:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:12 INFO - 'HOME': '/Users/cltbld', 18:52:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:12 INFO - 'LOGNAME': 'cltbld', 18:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:12 INFO - 'MOZ_NO_REMOTE': '1', 18:52:12 INFO - 'NO_EM_RESTART': '1', 18:52:12 INFO - 'PAGER': '/bin/cat', 18:52:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:12 INFO - 'PWD': '/builds/slave/test', 18:52:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:12 INFO - 'SHELL': '/bin/bash', 18:52:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:12 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:12 INFO - 'USER': 'cltbld', 18:52:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:12 INFO - 'XPC_FLAGS': '0x0', 18:52:12 INFO - 'XPC_SERVICE_NAME': '0', 18:52:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:12 INFO - Downloading/unpacking psutil>=3.1.1 18:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:52:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:14 INFO - Installing collected packages: psutil 18:52:14 INFO - Running setup.py install for psutil 18:52:14 INFO - building 'psutil._psutil_osx' extension 18:52:14 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 18:52:15 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 18:52:15 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 18:52:15 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 18:52:15 INFO - building 'psutil._psutil_posix' extension 18:52:15 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 18:52:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:52:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:52:15 INFO - ^ 18:52:15 INFO - 1 warning generated. 18:52:15 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 18:52:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:16 INFO - Successfully installed psutil 18:52:16 INFO - Cleaning up... 18:52:16 INFO - Return code: 0 18:52:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:16 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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:16 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 18:52:16 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 18:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:16 INFO - 'HOME': '/Users/cltbld', 18:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:16 INFO - 'LOGNAME': 'cltbld', 18:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:16 INFO - 'MOZ_NO_REMOTE': '1', 18:52:16 INFO - 'NO_EM_RESTART': '1', 18:52:16 INFO - 'PAGER': '/bin/cat', 18:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:16 INFO - 'PWD': '/builds/slave/test', 18:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:16 INFO - 'SHELL': '/bin/bash', 18:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:16 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:16 INFO - 'USER': 'cltbld', 18:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:16 INFO - 'XPC_FLAGS': '0x0', 18:52:16 INFO - 'XPC_SERVICE_NAME': '0', 18:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:52:16 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 18:52:16 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 18:52:16 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 18:52:16 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 18:52:16 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 18:52:16 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 18:52:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:52:19 INFO - Installing collected packages: mozsystemmonitor 18:52:19 INFO - Running setup.py install for mozsystemmonitor 18:52:19 INFO - Successfully installed mozsystemmonitor 18:52:19 INFO - Cleaning up... 18:52:19 INFO - Return code: 0 18:52:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:52:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:19 INFO - 'HOME': '/Users/cltbld', 18:52:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:19 INFO - 'LOGNAME': 'cltbld', 18:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:19 INFO - 'MOZ_NO_REMOTE': '1', 18:52:19 INFO - 'NO_EM_RESTART': '1', 18:52:19 INFO - 'PAGER': '/bin/cat', 18:52:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:19 INFO - 'PWD': '/builds/slave/test', 18:52:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:19 INFO - 'SHELL': '/bin/bash', 18:52:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:19 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:19 INFO - 'USER': 'cltbld', 18:52:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:19 INFO - 'XPC_FLAGS': '0x0', 18:52:19 INFO - 'XPC_SERVICE_NAME': '0', 18:52:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:19 INFO - Downloading/unpacking jsonschema==2.5.1 18:52:19 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 18:52:19 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 18:52:19 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 18:52:19 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 18:52:19 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 18:52:19 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 18:52:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:52:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:22 INFO - Downloading functools32-3.2.3-2.tar.gz 18:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:52:22 INFO - warning: no files found matching '*.txt' 18:52:22 INFO - no previously-included directories found matching 'build' 18:52:22 INFO - no previously-included directories found matching 'dist' 18:52:22 INFO - no previously-included directories found matching '.git*' 18:52:22 INFO - Installing collected packages: jsonschema, functools32 18:52:22 INFO - Running setup.py install for functools32 18:52:22 INFO - warning: no files found matching '*.txt' 18:52:22 INFO - no previously-included directories found matching 'build' 18:52:22 INFO - no previously-included directories found matching 'dist' 18:52:22 INFO - no previously-included directories found matching '.git*' 18:52:22 INFO - Successfully installed jsonschema functools32 18:52:22 INFO - Cleaning up... 18:52:22 INFO - Return code: 0 18:52:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:22 INFO - 'HOME': '/Users/cltbld', 18:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:22 INFO - 'LOGNAME': 'cltbld', 18:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:22 INFO - 'MOZ_NO_REMOTE': '1', 18:52:22 INFO - 'NO_EM_RESTART': '1', 18:52:22 INFO - 'PAGER': '/bin/cat', 18:52:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:22 INFO - 'PWD': '/builds/slave/test', 18:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:22 INFO - 'SHELL': '/bin/bash', 18:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:22 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:22 INFO - 'USER': 'cltbld', 18:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:22 INFO - 'XPC_FLAGS': '0x0', 18:52:22 INFO - 'XPC_SERVICE_NAME': '0', 18:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:22 INFO - Downloading/unpacking blobuploader==1.2.4 18:52:22 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 18:52:22 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 18:52:22 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 18:52:22 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 18:52:22 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 18:52:22 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 18:52:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:52:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:52:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:52:26 INFO - Downloading docopt-0.6.1.tar.gz 18:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:52:26 INFO - Installing collected packages: blobuploader, requests, docopt 18:52:26 INFO - Running setup.py install for blobuploader 18:52:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:52:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:52:26 INFO - Running setup.py install for requests 18:52:27 INFO - Running setup.py install for docopt 18:52:27 INFO - Successfully installed blobuploader requests docopt 18:52:27 INFO - Cleaning up... 18:52:27 INFO - Return code: 0 18:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:27 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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:27 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 18:52:27 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 18:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:27 INFO - 'HOME': '/Users/cltbld', 18:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:27 INFO - 'LOGNAME': 'cltbld', 18:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:27 INFO - 'MOZ_NO_REMOTE': '1', 18:52:27 INFO - 'NO_EM_RESTART': '1', 18:52:27 INFO - 'PAGER': '/bin/cat', 18:52:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:27 INFO - 'PWD': '/builds/slave/test', 18:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:27 INFO - 'SHELL': '/bin/bash', 18:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:27 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:27 INFO - 'USER': 'cltbld', 18:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:27 INFO - 'XPC_FLAGS': '0x0', 18:52:27 INFO - 'XPC_SERVICE_NAME': '0', 18:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:27 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-2MVpMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:27 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-0KXJHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-N5wcHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Gihr7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-UCoYLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-pvWsJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-a9tKv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-9G8CZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-5EnAJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-QHIrkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-d_Jgdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-1vAqJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-QjptVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-S3Ft30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-jzjQgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-kKkFML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Lb6cOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:52:29 INFO - Running setup.py install for manifestparser 18:52:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:52:29 INFO - Running setup.py install for mozcrash 18:52:29 INFO - Running setup.py install for mozdebug 18:52:30 INFO - Running setup.py install for mozdevice 18:52:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Running setup.py install for mozfile 18:52:30 INFO - Running setup.py install for mozhttpd 18:52:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Running setup.py install for mozinfo 18:52:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Running setup.py install for mozInstall 18:52:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:52:30 INFO - Running setup.py install for mozleak 18:52:30 INFO - Running setup.py install for mozlog 18:52:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:52:31 INFO - Running setup.py install for moznetwork 18:52:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:52:31 INFO - Running setup.py install for mozprocess 18:52:31 INFO - Running setup.py install for mozprofile 18:52:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:52:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:52:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:52:31 INFO - Running setup.py install for mozrunner 18:52:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:52:31 INFO - Running setup.py install for mozscreenshot 18:52:31 INFO - Running setup.py install for moztest 18:52:32 INFO - Running setup.py install for mozversion 18:52:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:52:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:52:32 INFO - Cleaning up... 18:52:32 INFO - Return code: 0 18:52:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:32 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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:32 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 18:52:32 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 18:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:32 INFO - 'HOME': '/Users/cltbld', 18:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:32 INFO - 'LOGNAME': 'cltbld', 18:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:32 INFO - 'MOZ_NO_REMOTE': '1', 18:52:32 INFO - 'NO_EM_RESTART': '1', 18:52:32 INFO - 'PAGER': '/bin/cat', 18:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:32 INFO - 'PWD': '/builds/slave/test', 18:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:32 INFO - 'SHELL': '/bin/bash', 18:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:32 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:32 INFO - 'USER': 'cltbld', 18:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:32 INFO - 'XPC_FLAGS': '0x0', 18:52:32 INFO - 'XPC_SERVICE_NAME': '0', 18:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-xork6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:32 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)) 18:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Y8FWri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:32 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)) 18:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-SqrLZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:32 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)) 18:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ddhrVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:32 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)) 18:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-___V9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-GdWoa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-wpxmEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-D8q5PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-rsb7ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-pjvsKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Y_B7x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-79z2e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-QJpTxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:33 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)) 18:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-nke2DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:34 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)) 18:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:34 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-sX553e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:34 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)) 18:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:34 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-I6lwIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:34 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)) 18:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:34 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-A64DX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:34 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)) 18:52:34 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)) 18:52:34 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)) 18:52:34 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)) 18:52:34 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)) 18:52:34 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)) 18:52:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:52:34 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 18:52:34 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 18:52:34 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 18:52:34 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 18:52:34 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 18:52:34 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 18:52:36 INFO - Downloading blessings-1.6.tar.gz 18:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:52:36 INFO - Installing collected packages: blessings 18:52:36 INFO - Running setup.py install for blessings 18:52:37 INFO - Successfully installed blessings 18:52:37 INFO - Cleaning up... 18:52:37 INFO - Return code: 0 18:52:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:37 INFO - Reading from file tmpfile_stdout 18:52:37 INFO - Current package versions: 18:52:37 INFO - blessings == 1.6 18:52:37 INFO - blobuploader == 1.2.4 18:52:37 INFO - docopt == 0.6.1 18:52:37 INFO - functools32 == 3.2.3-2 18:52:37 INFO - jsonschema == 2.5.1 18:52:37 INFO - manifestparser == 1.1 18:52:37 INFO - mozInstall == 1.12 18:52:37 INFO - mozcrash == 0.17 18:52:37 INFO - mozdebug == 0.1 18:52:37 INFO - mozdevice == 0.48 18:52:37 INFO - mozfile == 1.2 18:52:37 INFO - mozhttpd == 0.7 18:52:37 INFO - mozinfo == 0.9 18:52:37 INFO - mozleak == 0.1 18:52:37 INFO - mozlog == 3.2 18:52:37 INFO - moznetwork == 0.27 18:52:37 INFO - mozprocess == 0.23 18:52:37 INFO - mozprofile == 0.28 18:52:37 INFO - mozrunner == 6.12 18:52:37 INFO - mozscreenshot == 0.1 18:52:37 INFO - mozsystemmonitor == 0.3 18:52:37 INFO - moztest == 0.7 18:52:37 INFO - mozversion == 1.4 18:52:37 INFO - psutil == 3.1.1 18:52:37 INFO - requests == 1.2.3 18:52:37 INFO - wsgiref == 0.1.2 18:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:37 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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:37 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 18:52:37 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 18:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:37 INFO - 'HOME': '/Users/cltbld', 18:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:37 INFO - 'LOGNAME': 'cltbld', 18:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:37 INFO - 'MOZ_NO_REMOTE': '1', 18:52:37 INFO - 'NO_EM_RESTART': '1', 18:52:37 INFO - 'PAGER': '/bin/cat', 18:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:37 INFO - 'PWD': '/builds/slave/test', 18:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:37 INFO - 'SHELL': '/bin/bash', 18:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:37 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:37 INFO - 'USER': 'cltbld', 18:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:37 INFO - 'XPC_FLAGS': '0x0', 18:52:37 INFO - 'XPC_SERVICE_NAME': '0', 18:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 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)) 18:52:37 INFO - Cleaning up... 18:52:37 INFO - Return code: 0 18:52:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:52:37 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 0x10cd62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca58c8abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, '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.8XSv766oPs/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.cdpjSgt5Kw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 18:52:37 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 18:52:37 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 18:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:37 INFO - 'HOME': '/Users/cltbld', 18:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:37 INFO - 'LOGNAME': 'cltbld', 18:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:37 INFO - 'MOZ_NO_REMOTE': '1', 18:52:37 INFO - 'NO_EM_RESTART': '1', 18:52:37 INFO - 'PAGER': '/bin/cat', 18:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:37 INFO - 'PWD': '/builds/slave/test', 18:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:37 INFO - 'SHELL': '/bin/bash', 18:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:52:37 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:37 INFO - 'USER': 'cltbld', 18:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:37 INFO - 'XPC_FLAGS': '0x0', 18:52:37 INFO - 'XPC_SERVICE_NAME': '0', 18:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:52:38 INFO - Cleaning up... 18:52:38 INFO - Return code: 0 18:52:38 INFO - Running post-action listener: _resource_record_post_action 18:52:38 INFO - Running post-action listener: _start_resource_monitoring 18:52:38 INFO - Starting resource monitoring. 18:52:38 INFO - ##### 18:52:38 INFO - ##### Finished create-virtualenv step (success) 18:52:38 INFO - ##### 18:52:38 INFO - ##### 18:52:38 INFO - ##### Running install step. 18:52:38 INFO - ##### 18:52:38 INFO - Running pre-action listener: _resource_record_pre_action 18:52:38 INFO - Running main action method: install 18:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:38 INFO - Reading from file tmpfile_stdout 18:52:38 INFO - Detecting whether we're running mozinstall >=1.0... 18:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:52:38 INFO - Reading from file tmpfile_stdout 18:52:38 INFO - Output received: 18:52:38 INFO - Usage: mozinstall [options] installer 18:52:38 INFO - Options: 18:52:38 INFO - -h, --help show this help message and exit 18:52:38 INFO - -d DEST, --destination=DEST 18:52:38 INFO - Directory to install application into. [default: 18:52:38 INFO - "/builds/slave/test"] 18:52:38 INFO - --app=APP Application being installed. [default: firefox] 18:52:38 INFO - mkdir: /builds/slave/test/build/application 18:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:53:13 INFO - Reading from file tmpfile_stdout 18:53:13 INFO - Output received: 18:53:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:53:13 INFO - Running post-action listener: _resource_record_post_action 18:53:13 INFO - ##### 18:53:13 INFO - ##### Finished install step (success) 18:53:13 INFO - ##### 18:53:13 INFO - ##### 18:53:13 INFO - ##### Running run-tests step. 18:53:13 INFO - ##### 18:53:13 INFO - Running pre-action listener: _resource_record_pre_action 18:53:13 INFO - Running main action method: run_tests 18:53:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:53:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:53:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:53:13 INFO - 2016-07-15 18:53:13.097 screenresolution[1630:7533] starting screenresolution argv=screenresolution get 18:53:13 INFO - 2016-07-15 18:53:13.100 screenresolution[1630:7533] Display 0: 1600x1200x32@60 18:53:13 INFO - 2016-07-15 18:53:13.105 screenresolution[1631:7535] starting screenresolution argv=screenresolution list 18:53:13 INFO - Available Modes on Display 0 18:53:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:53:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:53:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:53:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:53:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:53:13 INFO - Intel Iris: 18:53:13 INFO - Chipset Model: Intel Iris 18:53:13 INFO - Type: GPU 18:53:13 INFO - Bus: Built-In 18:53:13 INFO - VRAM (Dynamic, Max): 1536 MB 18:53:13 INFO - Vendor: Intel (0x8086) 18:53:13 INFO - Device ID: 0x0a2e 18:53:13 INFO - Revision ID: 0x0009 18:53:13 INFO - Displays: 18:53:13 INFO - Display: 18:53:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:53:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:53:13 INFO - Display Serial Number: 1600x1200 60 18:53:13 INFO - Main Display: Yes 18:53:13 INFO - Mirror: Off 18:53:13 INFO - Online: Yes 18:53:13 INFO - Rotation: Supported 18:53:13 INFO - Return code: 0 18:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:53:13 INFO - Python 2.7.3 18:53:13 INFO - Return code: 0 18:53:13 INFO - grabbing minidump binary from tooltool 18:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:13 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 0x10ccc6d30>, '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 0x10ca2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:53:13 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 18:53:13 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 18:53:13 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 18:53:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:53:13 INFO - Return code: 0 18:53:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:53:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:53:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:53:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:53:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:53:13 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/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 18:53:13 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/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --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 18:53:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XSv766oPs/Render', 18:53:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:53:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:53:13 INFO - 'HOME': '/Users/cltbld', 18:53:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:53:13 INFO - 'LOGNAME': 'cltbld', 18:53:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:53:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:13 INFO - 'MOZ_NO_REMOTE': '1', 18:53:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:53:13 INFO - 'NO_EM_RESTART': '1', 18:53:13 INFO - 'PAGER': '/bin/cat', 18:53:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:13 INFO - 'PWD': '/builds/slave/test', 18:53:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:53:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:53:13 INFO - 'SHELL': '/bin/bash', 18:53:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cdpjSgt5Kw/Listeners', 18:53:13 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 18:53:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:53:13 INFO - 'USER': 'cltbld', 18:53:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:53:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:13 INFO - 'XPC_FLAGS': '0x0', 18:53:13 INFO - 'XPC_SERVICE_NAME': '0', 18:53:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:53:13 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/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 18:53:13 INFO - mozversion application_buildid: 20160715165053 18:53:13 INFO - mozversion application_changeset: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c 18:53:13 INFO - mozversion application_display_name: Nightly 18:53:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:53:13 INFO - mozversion application_name: Firefox 18:53:13 INFO - mozversion application_remotingname: firefox 18:53:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:53:13 INFO - mozversion application_vendor: Mozilla 18:53:13 INFO - mozversion application_version: 50.0a1 18:53:13 INFO - mozversion platform_buildid: 20160715165053 18:53:13 INFO - mozversion platform_changeset: 0d82d5d030afa2e8f48dd68e86eb75efd0947a5c 18:53:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:53:13 INFO - mozversion platform_version: 50.0a1 18:53:13 INFO - using testdate: 1468633993 18:53:13 INFO - actual date: 1468633993 18:53:13 INFO - starting webserver on 'localhost:49265' 18:53:13 INFO - SUITE-START | Running 2 tests 18:53:13 INFO - TEST-START | dromaeo_css 18:53:13 INFO - operating with platform_type : mac_ 18:53:13 INFO - Initialising browser for dromaeo_css test... 18:53:13 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmp1Uw7mT/profile http://localhost:49265/getInfo.html) 18:53:16 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 18:53:16 INFO - PROCESS | 1641 | colorDepth:24 18:53:16 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 18:53:16 INFO - PROCESS | 1641 | __metrics 18:53:17 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 18:53:17 INFO - TEST-INFO | 1641: exit 0 18:53:17 INFO - Browser initialized. 18:53:17 INFO - Running cycle 1/1 for dromaeo_css test... 18:53:17 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmp1Uw7mT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:30 INFO - PROCESS | 1644 | RSS: Main: 254595072 18:53:30 INFO - PROCESS | 1644 | 18:54:19 INFO - PROCESS | 1644 | 1468634059729 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] 18:56:30 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 18:56:31 INFO - PROCESS | 1644 | RSS: Main: 267534336 18:56:31 INFO - PROCESS | 1644 | 18:59:33 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 18:59:34 INFO - PROCESS | 1644 | RSS: Main: 275935232 18:59:34 INFO - PROCESS | 1644 | 19:02:36 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 19:02:37 INFO - PROCESS | 1644 | RSS: Main: 280346624 19:02:37 INFO - PROCESS | 1644 | 19:05:38 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 19:05:39 INFO - PROCESS | 1644 | RSS: Main: 279269376 19:05:39 INFO - PROCESS | 1644 | 19:08:42 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 19:08:42 INFO - PROCESS | 1644 | RSS: Main: 282906624 19:08:42 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 19:11:45 INFO - PROCESS | 1644 | RSS: Main: 283049984 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | __start_tp_report 19:11:45 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 19:11:45 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 19:11:45 INFO - PROCESS | 1644 | |i|pagename|runs| 19:11:45 INFO - PROCESS | 1644 | |0;dojo.html;2707.2419722477703;3050.1764523578636;3099.8295093769843;3403.6085850127242;3434.965650343496;5684.118961560955;5827.271591051119;5887.85280367991;5971.850703732409;5971.970140149293;4801.759912004394;5595.944040559593;5838.649681019142;5889.676067816268;5986.551008674345;5207.062728708831;5267.341582302212;5357.303550538424;5399;5442.673439593617;399.51829100512083;5222.556082732972;5246.449122842104;5291.603129765283;5293.232481290211;4270;5293;5300.09898317285;5342.813001544927;5360.973195134019;5325.760340784674;5336.946630533684;5352.170413585901;5362.276092727471;5392.110301800199;5186.662866913676;5198.4801519847715;5256.6057545684225;5263;5288.180332048539;5690.630109042941;5856.882862342772;5878.353381128072;5883.794067207627;5913.46778789911;6111.572189946705;6123.4351415035735;6174.135621013017;6181.227346581677;6186.505079593621;6148.600340977867;6148.7087711580625;6183.412575805336;6236.345183755686;6236.937630623726;6004.909926351064;6011.97796374613;6013.849837557488;6027.397260274025;6061.878762424727;6118.619179173164;6319.115323854572;6335.429811316912;6383.744650214032;6383.808485745435;6134.681512609229;6174.25908890927;6175.752969881154;6179.938200617937;6203;6175.62946223228;6192.589637460765;6260.718267677966;6270.31026587075;6271.43557079865;6102.67103564696;6108.190302030417;6111.266648002179;6161.784337548254;6193.225846769154;6091.939080609226;6164.352742961924;6168.907466388007;6181.381861813873;6198.938010619926;5047.16721740916;5062.544371006627;5066.9359434519165;5071.695698258042;5099.082165210298;4459.665525085632;4463.575960283768;4480.85738136773;4515.751633660115;4567;5215.843524694265;5472.288602481732;5722.427757224327;5906.173135760997;5980.461758441761;6213.2233470816145;6247.031710084944;6247.156633854463;6271.247450305992;6290.968545157245;5775.133729940459;5918.556108291896;5956.434138756811;5983.700814959235;5989.460948514655;5542.473465020817;5560.332760068818;5579.246801681802;5593.188987596775;5616.410276920865;6496.155499784998;6510.121133646897;6515.73937042513;6524.184476940382;6549.901751473827;6142.6314421134875;6153.476954458921;6180.598261113013;6204.224471941007;6211.3167551570195;5463.508284254436;6502.512311576556;6514.837129071811;6523.18460192476;6531.967340163269;5453.754581043783;5550.66783971852;6183.134361189347;6187.041008643668;6204.7828326008375;5264;6107.431569637723;6136.427173609184;6178.351273116258;6240.656763878031;5352.223927530408;6125.632462052291;6159.6612186330185;6163.35284795108;6170.228721409824;5634.436556344497;6148.4773794227995;6159.5072394209255;6170.568060235741;6175.320714721287;5974.880502390015;6034.547408944259;6039.305479869871;6100.2984656763265;6103.84740381494;6144.815655530341;6155.969220153871;6164.260288765377;6169.876602468015;6172.537059720628;5926.911096333472;6041.909371359521;6118.357572455006;6124.479419249414;6142.293636231891 19:11:45 INFO - PROCESS | 1644 | |1;ext.html;471.1824983653361;543.6737957225664;545.2285016701368;564.6188822544781;568.9829305120847;38530.03674908125;41345.379819302696;41597.376039359435;41624.37563436551;41658.791706041426;35946.460803087975;42611.934701632475;43432.782836085775;43576.78211608945;43611;9504.857427138615;9680.661176858812;9691.660791872286;9692.70921872345;9727.951360243189;9740.51297435129;9814.92035876053;9824.705258842247;9871.950640246825;9894.653687120952;9772.706818795448;9865.90134098657;9872.062154095349;9876.45679487628;9877.357971731815;8912.64349426022;9423.539351400545;9800;9867.309288349818;9896.257780666407;9719.416834989923;9793.559289831976;9799.314048016571;9816.509174541245;9837.803243935154;40537;40863.18273634541;40920.38619420711;41029.97425064397;41204.587954120376;3246.2533617267923;3446.293509830479;3448.5689288838894;3619.1133172372674;3644.3804553226014;27509.724902750917;29157.54212289377;30919.227019324473;31138.377232455223;31314.686853131407;3074.907752767398;3133.8903138390046;3181.172895047281;3190;3277.246233366315;447827;457479;530331;533100.334498325;536011.3199434017;33604;53563.928721425356;65715.01427478592;66140.66929665321;66201;28754.568681469795;33987.83006084954;34322.82838585791;34437.65562344395;34752.47871281933;14517;14557.490487832874;14784;15006;15032.699346013018;11482.138839586898;12213.877861221452;12680.80978785319;12759.553415630407;12782.424790884432;7585.544867307979;7643.923560764432;7664.65509052094;7679.76960691169;7751.806204844924;3208.4545627242956;3220.500822372536;3248.6588908164777;3256.869725210965;3285.950710739341;940.9837375634298;941.3551717073826;946.0823001688351;961.956711947964;981;29154.708452915198;29507.262318442212;29930.25174370658;30211.395772084874;30268.789248430257;1106.468894930438;1111.666500049998;1112.7885701716648;1122.5173175534599;1180.3803003423272;15989.440369587008;16239.025658460294;16325.612322952682;16331;16577.91711041461;164577.17711411367;165087;166220;543582;544717;57995;58084;58565.48607083588;58619.70690146522;58656.120158197664;1350.2776014832018;1410.9506167284096;1416.0300194367098;1423.1461123326128;1423.5088894331438;26127.38726127372;29764.53531970135;29908.252293692833;30667.693323066484;30905.518699787954;44165.33751993787;50775.49224507855;50778.74610626923;51141;51258.48741512686;451571;468932;469036;469170.30829691264;470047;26796.732032679425;26839.73160268372;26936.865315673294;27147.1855844325;27158.592621110303;48137.51862481471;48314.516854831;49000.50999489959;49358;49618.50381496139;38837.41743873901;40078.59921400749;40265.79867100763;40578.10835299867;40594.391084133174;39604.80197598993;39907.60092399039;40549.79725101356;40665;40742;35412.64587354093;37232;38571.614283857925;38595.03512412212;39748.40377394284;35400.645993539736;35905.64094359023;36237.91286261416;36377;36509.08727281839;23585;25969.831357588577;25998;26590;26653.86673066622 19:11:45 INFO - PROCESS | 1644 | |2;jquery.html;353.3110434652427;384.43680008787123;386.80659670164937;389.816786110528;396.8075483390557;19202.903985480072;20838.687419688697;20851.22764565014;21155.788442115576;21168;17487.95072295663;20147;20755.584888302226;21566.353009409704;21647;5729.971350143254;5765.5099316557935;5876.44173803488;5885.117232415129;5940.108983652443;5591.6365436246715;5807.9419205808035;5814.866101110285;5827.067669172933;5840.445157710011;5314.8838743863835;5474;5669.659820410768;5758.884822303551;5777.971110144444;5104.902445974115;5550;5754;5828.533717302648;5845.85385365365;4802.903941921177;5047.64666473347;5111.514406131449;5119.385673719177;5170.353705786777;13238.874695650882;13908.860911390959;21424.035918383554;24037.87981060101;24865.005399783986;1832.8808627439307;2157.1048015073725;2163.459135216196;2275.7041584594062;2278.100150440583;10236.283460157792;10265.897341026568;11546.769064618744;13309.933450332783;14514;1711.4181178399404;1737.54823745827;1779.2793918463044;1854.8701590888643;1880.652079365308;112677.43661281723;117288.82711172865;126588;130475;130665;11128.499217535069;11493.080553555696;11519.654410367702;11530.423478826026;11623.547056617923;14470.565883023526;14505.564833055025;14597.41610335596;14607.926960365343;14608.9773715841;8596.312295016383;8659.307255419551;8700.608472618747;8704.956475217583;8809.647614095493;8811.867821982676;8837.690680826141;8860.512671802984;8923.553822308859;8964.238039766562;4501.459824821042;4515.412996310459;4530.478994915627;4558.840440584564;4568.70303430276;1621.4381277581392;1958.0894883879064;1960.3530834824473;1961.7253584498183;1966.9803301967083;761.6344154805724;865.6063737382808;868.7046404222468;915.6795121707349;1035.7307100154014;21564.568708626055;21683.783162168493;21684.02421891019;21914.561708765734;21919.890400548215;941.4022095969109;942.528735632184;942.8962814090445;943.6791490893129;1022.2140700677663;9925.30522863407;10003;10389.168866490663;11205.887941120647;11539;242142;244606;244885.775571121;465849;618958;124062.37968810098;126446.10330845045;126818.36590816987;140431.29784351014;145105;762.904636920385;844.0588743550896;844.0673056272731;844.6536919862826;845.8266055458616;17808.643827123644;18345.72481412753;19078;19105.14026868822;19211.135498902302;37443;54859;57737;57859.84280314286;59051;78699.6065019694;85227;85760;86145.56927215324;87982.1201787974;7681.961590192013;8075.636596353295;8083.676652934052;8287.709930152416;8337.291330236998;9164.175224229852;10976.945115274373;12123.878761212274;13061.08572399961;13335.866641333463;9711.854322185314;11409;11473.685784491989;11618.883811162119;11643.825342620037;10771.676849694522;11421.31472111676;11561.884381156417;11567.325840234613;11601.76796464049;11024.338539687644;11626.186166968231;11632.53469861196;11666.416679165837;11733.413329333669;8066.516009039477;8138.83722325562;8170.142135075732;8277;8281.509328320719;8953.955230223808;9717;10740.71111466629;11525.250858694159;11657.650270491898 19:11:45 INFO - PROCESS | 1644 | |3;mootools.html;1561.5627624265203;1597.5766421898197;1836.4857839804852;1914.100372824772;1918.5779128591705;8083.878741818878;8618.267447266973;8632.093630168836;9180.8622870657;9188.127127922846;8700.695475658353;8812.823743525125;8878.467291962486;8932.062133475989;8942.59758310876;2344.894479748411;2360.858348499087;2366.715994080704;2368.3605426534828;2386.319898828834;2289.5192009677903;2343.4492894169857;2355.5053438777877;2380.1550449590404;2404.158544509425;2348.495073559184;2356.929292121239;2363.5154793267425;2364.9645255321184;2365.89353479093;2207.150247154841;2210.613142700029;2225.8664480131165;2227.6992605998225;2233.8659680419064;2285.2801367569164;2315.1896836107394;2324.0819876148826;2330.4639932815376;2331.9650205246935;8925.062868398854;9007.324450666227;9026.007139214682;9045.909540904639;9068.727938161866;5154.793808247666;5286.471352864722;5309;5309.707966061865;5333.946660533384;3339.2820543583002;3410.7100896423835;3485.9825700871334;3576.910577235564;3606.9819650901577;1080.2438293194796;1090.9672709818717;1783.4025601423539;1865.4496923407628;1875.5873707784265;11632.06943444531;11655.358955257458;11766.058715302755;11797.88202117985;11802.232854864405;3903.375459926398;4418.094290670405;4478.417805685305;4623.283391074388;4631.328457373662;9216.95391523038;9281.21109705669;9285.164335209864;9287.582058807235;9294.256459483226;5175.585953123741;5201.739913004335;5205.141151709925;5217.113090774577;5217.608679349064;4346.130773845243;4759.262314341283;4769.833055843029;4882.853514394574;4893.486183950705;3783.0920579060826;3813.7902415366866;3857.672097871656;3887.922241555153;3924.156306394082;1171.7363593191465;1179.6932797472718;1191.880811918801;1194.8685644579089;1205.3009254632293;908.5956749246521;918.5958178401482;923.7275003873739;947.1388721162948;969.2698533118349;5933.703314834241;5995.760169593167;5999.340072592011;6072.210612620331;6137.539684523589;418.8806190235768;426.86553735573193;441.46582635011356;446.54006373435413;448.73524620474075;3937.940930886039;4070.3487442009136;4075.5313138989395;4078.632923036941;4080.5307389649975;10522.736931576772;10941.890581094087;10971;11054.673439187349;11054.944725276322;10711.78576428467;10742.3017503862;10791.83812242817;10885.727856803644;10901.073408760345;6620.106285651472;7052.682629281695;7718.768436946901;8409.873851892227;8423.410361274651;5851.61964472308;5946.316173640087;5973.313068997121;6082.665453399928;6181.505479561534;9663.661771837951;10000.44997525114;10137.746556336151;10177.949110254698;10201.897981020094;8605.870911936201;10215.02957219063;10269.794604108025;10297.3821570706;10342.638007669997;6644.302348253364;7397.26027397256;7417.1841097478155;7444.367228785614;7568.810779730551;8529.82940341202;8574.013988391414;8608.65565377378;8609.48343099416;8611.569421529024;7549.660265287966;7726.227377262228;7771.494852834548;7784.727534536264;7795.532268063935;7449.180590134973;7473.327400533978;7522.172561018174;7555.6977720890545;7621.961890190513;6994.125734283215;7033.402160816388;7075.964620177072;7089.503734738725;7147;4874.2444921037295;5067.543921047123;5139.408967968731;5147.6654017488745;5161.948380516147;5107.719075450886;5136.717480538457;5140.948590514047;5293.629445938747;5294.391145018372 19:11:45 INFO - PROCESS | 1644 | |4;prototype.html;306.6596078353028;310.86322018311944;314.9795263307885;315.3267773303995;319.3564966592318;5262.605514490911;5730.56735816046;5732.484076433126;5778.393268706788;5790.913136302948;4898.657094003421;5056.241563765428;5580.330360356753;5680.659160450376;5686.488216060554;3357.6474470180647;4081.918291652722;4170.040890595165;4285.90709369112;4329.406592528194;3560.6973407260284;4249.7476337541;4282.828686852522;4302.440682711243;4329.372241025049;3512.9297414051703;4246.532881383061;4264.296391095481;4264.872053838374;4282.635975942033;4140.77225752585;4264.658827293809;4282.828686852522;4289.24938135825;4304.182205380999;2884.754795842356;3227.887023954174;3702.8518859245596;3711.3319602471543;3725.0013738940143;4475.955240447586;5510.8071217507195;5515.696636684981;5524.447555244444;5541.090927263179;3827.291950989048;3979.5025621797276;4227.323628219501;4959.70241785494;4987.376577927759;5196.791363670425;5484.424135465799;5636.605437619368;5732.770689172428;5891.582881928472;3351.497275408684;3983.960160398417;4018.296798060357;4024.436578878959;4036.899077523056;4774;5730.713464326809;5758.560359910022;6282.623042617412;6327.24073111225;3592.8742494012586;4198.517170525429;4229.6827737919775;4247.8088486018205;4263.211305908417;3944.8165550334784;4073.837046518106;4252.277112890754;4255.446791917093;4341.979634785823;4676.321933319649;4999.200127979506;4999.325091112653;5004.374453193351;5022.723750193774;5011.799528018912;6096.110205836205;6115.021596544531;6118.816435506942;6127.295361033449;1458.8985316086287;1475.6384685751846;1475.7343678138038;1477.0251633921775;1479.5117611188282;856.6787454704486;903.96947479873;907.7775944893543;919.7332773495611;920.8857282688023;4256.212390795873;4466.932996005063;4866.902661946741;5111.488851114858;5551.666899986014;5107.391171780877;5718.71328950991;6131.693415329216;6138.508919286446;6160;4578.709734287931;4665.9766701166955;4682.792287283222;5508.55931525477;5532.589189756586;2661.0021242034236;3097.915729494659;3179.5071763876635;3232.5636039134415;3250.837458127084;4764.118638051971;5564.8330550083565;5922.466977972003;6018.849528761816;6307.653079080603;5700.157338727837;5902.527797776168;5970.940290597126;6220.7511699532415;6354.491640668735;6275.677999140347;6299.488122850575;6306.432421082125;6335.384476958347;6347;5082.644214904921;5755.280589926259;5980;6094.299155597163;6133.325334213144;5824.912626310694;5905.675187864708;6040.818775436744;6051.515878729779;6077.361877002851;5625.549956003428;5936.614120082181;5970.611910225822;6315.96842015787;6320.62076275425;3179;3860.8841734748003;4088.855120566246;4183.602557757008;4213.620774130343;5525.811950430677;5549.505989070872;5651.378348381757;6042.456178943916;6132.233470816148;5174.365384804663;5474.589405794661;5813.244278243801;5888.054034610947;5934.970325148347;5201.687898726089;5849.718609742119;5914.201582786441;5918.496927761188;5934.881302374015;5349.518543331119;5532.889342213214;5729.398413166724;5777.24895763548;5814.592978491465;4951.9449428488215;5612.7754889803955;5959.3183067618875;6036.517078633787;6078.878422431439;5850.356460789225;5878.735456904364;5894.498967587803;5896.292444906639;5951.821445356646 19:11:45 INFO - PROCESS | 1644 | |5;yui.html;744.2297222374843;752.5259086775334;797.9162187970263;814.3363159025394;815.2744057788566;15168.772468412968;15762.054276743404;15933.760993585076;15934.521964341075;15982.041077535341;14371.281435928215;14490.20303883286;14502.347394367252;14512.709745805078;14513.854861451382;704.264044073944;871.2289623683023;878.6573236437779;900.3877363392891;901.143913282381;898.1243287794381;898.6135961536537;900.6442455230181;908.8639200998751;910.4309806371018;945.1588086602928;961.7980224152936;962.8940816510213;963.5471328475605;964.9276304277172;804.6419343392192;949.1884438804791;950.273041123541;958.5111593087506;959.3811991265629;703.8521910398822;705.1256442011919;706.6855249414012;707.4835370179746;709.2977951827653;15547.378104875905;15572.143532105729;15608.531744047697;15673.686526269525;15751.2124393781;14878.70242595153;14959.252037398086;15005.69988600222;15026.17356045417;15217.847821521755;12002.879971200351;12206.389680515938;12252.379343917004;12466.937665311707;12568.622941311774;3883.475730776337;3930;4101.302778527627;4125.66994640431;4138.110306284163;114968;115508;116051.77767000505;116925;117164.65670686538;11393.487293071832;11467.623885133671;11550.537978480766;11601.941990289995;11655.30068195911;20579;24136.63795043076;24292.271231863073;24325.51348973046;24613.507729845303;7795.80510487231;8013.519188848688;8119.79700507492;8222.13667564909;8484.915150848536;4479.977600111979;4530.411046563926;4591.334256532851;4632.420947381577;4662.6269898408045;3592.8023958682525;3996.86010989614;4184.895377615584;4187.727797693201;4236.6187043166265;730.4047201530735;735.5917465806422;739.8742213823663;740.3558903753768;748.4386709967524;574.8304250246188;636.312782195228;664.2029564522592;676.6988690032987;683.6205905722372;7897.24976127267;8725;9107.08929107084;9350.786277688854;9720.805583888283;564.601955621286;570.3925319534765;618.7896115320813;624.7688355308564;662.2483481248818;4702.4592171899985;4768.356271903318;4785.234362502053;4804.915821551723;4853.505778810898;98867;110014.44992774985;149453;153110;157140.21429893005;106744.46627766812;107233.46383268034;107552;107823;108502.3724644131;118898.40550797191;120408.5509738837;120420.99999999825;122994.15508767376;125865.37067314606;8832.337574682053;9037.638494460149;9097.454152750855;9166.724998250063;9198.954005230198;59437.81124377402;61278.38721612727;63890.36109638844;65874;66866.99699504414;70310;96633.0336696624;98391.95829188646;100854.49572752089;101770;13614.659633509242;14167.362468688727;14298.999070064996;14383.971291865862;15218.086914785148;15272;15488.07071575709;15502.457413990456;15727;16252.10613416226;14187.64530886736;14190.290485475478;14441.205733684748;14461.276936153361;14661.413543458142;14171.929140354232;14258.429662813785;14447.566573002827;15066.020708653903;15194.468193613171;13722.794158087438;14035;14309.998300118892;14459.493917712829;14807.333669985092;11198.608048718255;11445.313281203154;11450.37022963745;11599.88400115988;12074.335911524951;10687.786244274916;11042.33745975244;11319.535889090346;11491.770164596493;11772.587959421722 19:11:45 INFO - PROCESS | 1644 | __end_tp_report 19:11:45 INFO - PROCESS | 1644 | __start_cc_report 19:11:45 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,445 19:11:45 INFO - PROCESS | 1644 | __end_cc_report 19:11:45 INFO - PROCESS | 1644 | __startTimestamp1468635105833__endTimestamp 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | ------- Summary: start ------- 19:11:45 INFO - PROCESS | 1644 | Number of tests: 6 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5739.78 Median:6034.55 stddev:789.26 (13.1%) stddev-sans-first:754.97 19:11:45 INFO - PROCESS | 1644 | Values: 2707.2 3050.2 3099.8 3403.6 3435.0 5684.1 5827.3 5887.9 5971.9 5972.0 4801.8 5595.9 5838.6 5889.7 5986.6 5207.1 5267.3 5357.3 5399.0 5442.7 399.5 5222.6 5246.4 5291.6 5293.2 4270.0 5293.0 5300.1 5342.8 5361.0 5325.8 5336.9 5352.2 5362.3 5392.1 5186.7 5198.5 5256.6 5263.0 5288.2 5690.6 5856.9 5878.4 5883.8 5913.5 6111.6 6123.4 6174.1 6181.2 6186.5 6148.6 6148.7 6183.4 6236.3 6236.9 6004.9 6012.0 6013.8 6027.4 6061.9 6118.6 6319.1 6335.4 6383.7 6383.8 6134.7 6174.3 6175.8 6179.9 6203.0 6175.6 6192.6 6260.7 6270.3 6271.4 6102.7 6108.2 6111.3 6161.8 6193.2 6091.9 6164.4 6168.9 6181.4 6198.9 5047.2 5062.5 5066.9 5071.7 5099.1 4459.7 4463.6 4480.9 4515.8 4567.0 5215.8 5472.3 5722.4 5906.2 5980.5 6213.2 6247.0 6247.2 6271.2 6291.0 5775.1 5918.6 5956.4 5983.7 5989.5 5542.5 5560.3 5579.2 5593.2 5616.4 6496.2 6510.1 6515.7 6524.2 6549.9 6142.6 6153.5 6180.6 6204.2 6211.3 5463.5 6502.5 6514.8 6523.2 6532.0 5453.8 5550.7 6183.1 6187.0 6204.8 5264.0 6107.4 6136.4 6178.4 6240.7 5352.2 6125.6 6159.7 6163.4 6170.2 5634.4 6148.5 6159.5 6170.6 6175.3 5974.9 6034.5 6039.3 6100.3 6103.8 6144.8 6156.0 6164.3 6169.9 6172.5 5926.9 6041.9 6118.4 6124.5 6142.3 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:57349.37 Median:40401.40 stddev:119947.13 (296.9%) stddev-sans-first:120207.59 19:11:45 INFO - PROCESS | 1644 | Values: 471.2 543.7 545.2 564.6 569.0 38530.0 41345.4 41597.4 41624.4 41658.8 35946.5 42611.9 43432.8 43576.8 43611.0 9504.9 9680.7 9691.7 9692.7 9728.0 9740.5 9814.9 9824.7 9872.0 9894.7 9772.7 9865.9 9872.1 9876.5 9877.4 8912.6 9423.5 9800.0 9867.3 9896.3 9719.4 9793.6 9799.3 9816.5 9837.8 40537.0 40863.2 40920.4 41030.0 41204.6 3246.3 3446.3 3448.6 3619.1 3644.4 27509.7 29157.5 30919.2 31138.4 31314.7 3074.9 3133.9 3181.2 3190.0 3277.2 447827.0 457479.0 530331.0 533100.3 536011.3 33604.0 53563.9 65715.0 66140.7 66201.0 28754.6 33987.8 34322.8 34437.7 34752.5 14517.0 14557.5 14784.0 15006.0 15032.7 11482.1 12213.9 12680.8 12759.6 12782.4 7585.5 7643.9 7664.7 7679.8 7751.8 3208.5 3220.5 3248.7 3256.9 3286.0 941.0 941.4 946.1 962.0 981.0 29154.7 29507.3 29930.3 30211.4 30268.8 1106.5 1111.7 1112.8 1122.5 1180.4 15989.4 16239.0 16325.6 16331.0 16577.9 164577.2 165087.0 166220.0 543582.0 544717.0 57995.0 58084.0 58565.5 58619.7 58656.1 1350.3 1411.0 1416.0 1423.1 1423.5 26127.4 29764.5 29908.3 30667.7 30905.5 44165.3 50775.5 50778.7 51141.0 51258.5 451571.0 468932.0 469036.0 469170.3 470047.0 26796.7 26839.7 26936.9 27147.2 27158.6 48137.5 48314.5 49000.5 49358.0 49618.5 38837.4 40078.6 40265.8 40578.1 40594.4 39604.8 39907.6 40549.8 40665.0 40742.0 35412.6 37232.0 38571.6 38595.0 39748.4 35400.6 35905.6 36237.9 36377.0 36509.1 23585.0 25969.8 25998.0 26590.0 26653.9 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:28849.45 Median:133089.94 stddev:69437.70 (52.2%) stddev-sans-first:69599.53 19:11:45 INFO - PROCESS | 1644 | Values: 353.3 384.4 386.8 389.8 396.8 19202.9 20838.7 20851.2 21155.8 21168.0 17488.0 20147.0 20755.6 21566.4 21647.0 5730.0 5765.5 5876.4 5885.1 5940.1 5591.6 5807.9 5814.9 5827.1 5840.4 5314.9 5474.0 5669.7 5758.9 5778.0 5104.9 5550.0 5754.0 5828.5 5845.9 4802.9 5047.6 5111.5 5119.4 5170.4 13238.9 13908.9 21424.0 24037.9 24865.0 1832.9 2157.1 2163.5 2275.7 2278.1 10236.3 10265.9 11546.8 13309.9 14514.0 1711.4 1737.5 1779.3 1854.9 1880.7 112677.4 117288.8 126588.0 130475.0 130665.0 11128.5 11493.1 11519.7 11530.4 11623.5 14470.6 14505.6 14597.4 14607.9 14609.0 8596.3 8659.3 8700.6 8705.0 8809.6 8811.9 8837.7 8860.5 8923.6 8964.2 4501.5 4515.4 4530.5 4558.8 4568.7 1621.4 1958.1 1960.4 1961.7 1967.0 761.6 865.6 868.7 915.7 1035.7 21564.6 21683.8 21684.0 21914.6 21919.9 941.4 942.5 942.9 943.7 1022.2 9925.3 10003.0 10389.2 11205.9 11539.0 242142.0 244606.0 244885.8 465849.0 618958.0 124062.4 126446.1 126818.4 140431.3 145105.0 762.9 844.1 844.1 844.7 845.8 17808.6 18345.7 19078.0 19105.1 19211.1 37443.0 54859.0 57737.0 57859.8 59051.0 78699.6 85227.0 85760.0 86145.6 87982.1 7682.0 8075.6 8083.7 8287.7 8337.3 9164.2 10976.9 12123.9 13061.1 13335.9 9711.9 11409.0 11473.7 11618.9 11643.8 10771.7 11421.3 11561.9 11567.3 11601.8 11024.3 11626.2 11632.5 11666.4 11733.4 8066.5 8138.8 8170.1 8277.0 8281.5 8954.0 9717.0 10740.7 11525.3 11657.7 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5720.92 Median:4822.04 stddev:3217.01 (66.7%) stddev-sans-first:3210.85 19:11:45 INFO - PROCESS | 1644 | Values: 1561.6 1597.6 1836.5 1914.1 1918.6 8083.9 8618.3 8632.1 9180.9 9188.1 8700.7 8812.8 8878.5 8932.1 8942.6 2344.9 2360.9 2366.7 2368.4 2386.3 2289.5 2343.4 2355.5 2380.2 2404.2 2348.5 2356.9 2363.5 2365.0 2365.9 2207.2 2210.6 2225.9 2227.7 2233.9 2285.3 2315.2 2324.1 2330.5 2332.0 8925.1 9007.3 9026.0 9045.9 9068.7 5154.8 5286.5 5309.0 5309.7 5333.9 3339.3 3410.7 3486.0 3576.9 3607.0 1080.2 1091.0 1783.4 1865.4 1875.6 11632.1 11655.4 11766.1 11797.9 11802.2 3903.4 4418.1 4478.4 4623.3 4631.3 9217.0 9281.2 9285.2 9287.6 9294.3 5175.6 5201.7 5205.1 5217.1 5217.6 4346.1 4759.3 4769.8 4882.9 4893.5 3783.1 3813.8 3857.7 3887.9 3924.2 1171.7 1179.7 1191.9 1194.9 1205.3 908.6 918.6 923.7 947.1 969.3 5933.7 5995.8 5999.3 6072.2 6137.5 418.9 426.9 441.5 446.5 448.7 3937.9 4070.3 4075.5 4078.6 4080.5 10522.7 10941.9 10971.0 11054.7 11054.9 10711.8 10742.3 10791.8 10885.7 10901.1 6620.1 7052.7 7718.8 8409.9 8423.4 5851.6 5946.3 5973.3 6082.7 6181.5 9663.7 10000.4 10137.7 10177.9 10201.9 8605.9 10215.0 10269.8 10297.4 10342.6 6644.3 7397.3 7417.2 7444.4 7568.8 8529.8 8574.0 8608.7 8609.5 8611.6 7549.7 7726.2 7771.5 7784.7 7795.5 7449.2 7473.3 7522.2 7555.7 7622.0 6994.1 7033.4 7076.0 7089.5 7147.0 4874.2 5067.5 5139.4 5147.7 5161.9 5107.7 5136.7 5140.9 5293.6 5294.4 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4745.55 Median:5412.05 stddev:1478.10 (27.3%) stddev-sans-first:1444.21 19:11:45 INFO - PROCESS | 1644 | Values: 306.7 310.9 315.0 315.3 319.4 5262.6 5730.6 5732.5 5778.4 5790.9 4898.7 5056.2 5580.3 5680.7 5686.5 3357.6 4081.9 4170.0 4285.9 4329.4 3560.7 4249.7 4282.8 4302.4 4329.4 3512.9 4246.5 4264.3 4264.9 4282.6 4140.8 4264.7 4282.8 4289.2 4304.2 2884.8 3227.9 3702.9 3711.3 3725.0 4476.0 5510.8 5515.7 5524.4 5541.1 3827.3 3979.5 4227.3 4959.7 4987.4 5196.8 5484.4 5636.6 5732.8 5891.6 3351.5 3984.0 4018.3 4024.4 4036.9 4774.0 5730.7 5758.6 6282.6 6327.2 3592.9 4198.5 4229.7 4247.8 4263.2 3944.8 4073.8 4252.3 4255.4 4342.0 4676.3 4999.2 4999.3 5004.4 5022.7 5011.8 6096.1 6115.0 6118.8 6127.3 1458.9 1475.6 1475.7 1477.0 1479.5 856.7 904.0 907.8 919.7 920.9 4256.2 4466.9 4866.9 5111.5 5551.7 5107.4 5718.7 6131.7 6138.5 6160.0 4578.7 4666.0 4682.8 5508.6 5532.6 2661.0 3097.9 3179.5 3232.6 3250.8 4764.1 5564.8 5922.5 6018.8 6307.7 5700.2 5902.5 5970.9 6220.8 6354.5 6275.7 6299.5 6306.4 6335.4 6347.0 5082.6 5755.3 5980.0 6094.3 6133.3 5824.9 5905.7 6040.8 6051.5 6077.4 5625.5 5936.6 5970.6 6316.0 6320.6 3179.0 3860.9 4088.9 4183.6 4213.6 5525.8 5549.5 5651.4 6042.5 6132.2 5174.4 5474.6 5813.2 5888.1 5935.0 5201.7 5849.7 5914.2 5918.5 5934.9 5349.5 5532.9 5729.4 5777.2 5814.6 4951.9 5612.8 5959.3 6036.5 6078.9 5850.4 5878.7 5894.5 5896.3 5951.8 19:11:45 INFO - PROCESS | 1644 | 19:11:45 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:24758.22 Median:14103.16 stddev:38343.59 (271.9%) stddev-sans-first:38408.76 19:11:45 INFO - PROCESS | 1644 | Values: 744.2 752.5 797.9 814.3 815.3 15168.8 15762.1 15933.8 15934.5 15982.0 14371.3 14490.2 14502.3 14512.7 14513.9 704.3 871.2 878.7 900.4 901.1 898.1 898.6 900.6 908.9 910.4 945.2 961.8 962.9 963.5 964.9 804.6 949.2 950.3 958.5 959.4 703.9 705.1 706.7 707.5 709.3 15547.4 15572.1 15608.5 15673.7 15751.2 14878.7 14959.3 15005.7 15026.2 15217.8 12002.9 12206.4 12252.4 12466.9 12568.6 3883.5 3930.0 4101.3 4125.7 4138.1 114968.0 115508.0 116051.8 116925.0 117164.7 11393.5 11467.6 11550.5 11601.9 11655.3 20579.0 24136.6 24292.3 24325.5 24613.5 7795.8 8013.5 8119.8 8222.1 8484.9 4480.0 4530.4 4591.3 4632.4 4662.6 3592.8 3996.9 4184.9 4187.7 4236.6 730.4 735.6 739.9 740.4 748.4 574.8 636.3 664.2 676.7 683.6 7897.2 8725.0 9107.1 9350.8 9720.8 564.6 570.4 618.8 624.8 662.2 4702.5 4768.4 4785.2 4804.9 4853.5 98867.0 110014.4 149453.0 153110.0 157140.2 106744.5 107233.5 107552.0 107823.0 108502.4 118898.4 120408.6 120421.0 122994.2 125865.4 8832.3 9037.6 9097.5 9166.7 9199.0 59437.8 61278.4 63890.4 65874.0 66867.0 70310.0 96633.0 98392.0 100854.5 101770.0 13614.7 14167.4 14299.0 14384.0 15218.1 15272.0 15488.1 15502.5 15727.0 16252.1 14187.6 14190.3 14441.2 14461.3 14661.4 14171.9 14258.4 14447.6 15066.0 15194.5 13722.8 14035.0 14310.0 14459.5 14807.3 11198.6 11445.3 11450.4 11599.9 12074.3 10687.8 11042.3 11319.5 11491.8 11772.6 19:11:45 INFO - PROCESS | 1644 | -------- Summary: end -------- 19:11:45 INFO - PROCESS | 1644 | 19:11:46 INFO - TEST-INFO | 1644: exit 0 19:11:46 INFO - TEST-OK | dromaeo_css | took 1112803ms 19:11:46 INFO - TEST-START | kraken 19:11:46 INFO - operating with platform_type : mac_ 19:11:46 INFO - Initialising browser for kraken test... 19:11:46 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpzyMnCk/profile http://localhost:49265/getInfo.html) 19:11:49 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 19:11:49 INFO - PROCESS | 1656 | colorDepth:24 19:11:49 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 19:11:49 INFO - PROCESS | 1656 | __metrics 19:11:49 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:11:49 INFO - TEST-INFO | 1656: exit 0 19:11:49 INFO - Browser initialized. 19:11:49 INFO - Running cycle 1/1 for kraken test... 19:11:49 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpzyMnCk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:02 INFO - PROCESS | 1658 | RSS: Main: 254394368 19:12:02 INFO - PROCESS | 1658 | 19:12:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 19:12:05 INFO - PROCESS | 1658 | RSS: Main: 267300864 19:12:05 INFO - PROCESS | 1658 | 19:12:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 19:12:09 INFO - PROCESS | 1658 | RSS: Main: 271421440 19:12:09 INFO - PROCESS | 1658 | 19:12:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 19:12:13 INFO - PROCESS | 1658 | RSS: Main: 271884288 19:12:13 INFO - PROCESS | 1658 | 19:12:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 19:12:15 INFO - PROCESS | 1658 | RSS: Main: 272936960 19:12:15 INFO - PROCESS | 1658 | 19:12:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:12:18 INFO - PROCESS | 1658 | RSS: Main: 273518592 19:12:18 INFO - PROCESS | 1658 | 19:12:21 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 19:12:22 INFO - PROCESS | 1658 | RSS: Main: 274071552 19:12:22 INFO - PROCESS | 1658 | 19:12:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 19:12:25 INFO - PROCESS | 1658 | RSS: Main: 274276352 19:12:25 INFO - PROCESS | 1658 | 19:12:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 19:12:29 INFO - PROCESS | 1658 | RSS: Main: 274022400 19:12:29 INFO - PROCESS | 1658 | 19:12:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:12:31 INFO - PROCESS | 1658 | RSS: Main: 274022400 19:12:31 INFO - PROCESS | 1658 | 19:12:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:12:34 INFO - PROCESS | 1658 | RSS: Main: 273887232 19:12:34 INFO - PROCESS | 1658 | 19:12:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:12:37 INFO - PROCESS | 1658 | RSS: Main: 273948672 19:12:37 INFO - PROCESS | 1658 | 19:12:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:12:41 INFO - PROCESS | 1658 | RSS: Main: 274059264 19:12:41 INFO - PROCESS | 1658 | 19:12:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:12:44 INFO - PROCESS | 1658 | RSS: Main: 273985536 19:12:44 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 19:12:46 INFO - PROCESS | 1658 | RSS: Main: 274796544 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | __start_tp_report 19:12:46 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 19:12:46 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 19:12:46 INFO - PROCESS | 1658 | |i|pagename|runs| 19:12:46 INFO - PROCESS | 1658 | |0;ai-astar;118;165;107;121;97;156;162;169;116;115 19:12:46 INFO - PROCESS | 1658 | |1;audio-beat-detection;148;132;160;154;111;142;129;110;190;113 19:12:46 INFO - PROCESS | 1658 | |2;audio-dft;194;206;240;212;198;201;200;201;201;176 19:12:46 INFO - PROCESS | 1658 | |3;audio-fft;73;84;77;146;60;58;59;64;131;61 19:12:46 INFO - PROCESS | 1658 | |4;audio-oscillator;69;71;119;71;72;111;113;69;74;130 19:12:46 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;78;135;127;88;85;88;101;108;128 19:12:46 INFO - PROCESS | 1658 | |6;imaging-darkroom;97;151;119;99;96;96;98;106;147;94 19:12:46 INFO - PROCESS | 1658 | |7;imaging-desaturate;144;145;88;148;146;118;89;91;93;91 19:12:46 INFO - PROCESS | 1658 | |8;json-parse-financial;56;56;58;65;82;82;81;59;56;56 19:12:46 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;67;75;89;59;97;114;107;105;78;72 19:12:46 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;84;83;82;87;81;88;85;88;81;102 19:12:46 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;135;139;145;150;147;145;151;149;242;142 19:12:46 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;166;171;167;170;169;164;163;162;202;220 19:12:46 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;66;71;65;69;64;64;64;69;64 19:12:46 INFO - PROCESS | 1658 | __end_tp_report 19:12:46 INFO - PROCESS | 1658 | __start_cc_report 19:12:46 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1125 19:12:46 INFO - PROCESS | 1658 | __end_cc_report 19:12:46 INFO - PROCESS | 1658 | __startTimestamp1468635166527__endTimestamp 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | ------- Summary: start ------- 19:12:46 INFO - PROCESS | 1658 | Number of tests: 14 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:132.60 Median:159.00 stddev:27.17 (17.1%) stddev-sans-first:28.30 19:12:46 INFO - PROCESS | 1658 | Values: 118.0 165.0 107.0 121.0 97.0 156.0 162.0 169.0 116.0 115.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:145.00 stddev:25.40 (17.5%) stddev-sans-first:26.73 19:12:46 INFO - PROCESS | 1658 | Values: 148.0 132.0 160.0 154.0 111.0 142.0 129.0 110.0 190.0 113.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:202.90 Median:201.00 stddev:16.04 (8.0%) stddev-sans-first:16.68 19:12:46 INFO - PROCESS | 1658 | Values: 194.0 206.0 240.0 212.0 198.0 201.0 200.0 201.0 201.0 176.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:81.30 Median:62.50 stddev:31.55 (50.5%) stddev-sans-first:33.32 19:12:46 INFO - PROCESS | 1658 | Values: 73.0 84.0 77.0 146.0 60.0 58.0 59.0 64.0 131.0 61.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:70.00 stddev:24.93 (35.6%) stddev-sans-first:25.27 19:12:46 INFO - PROCESS | 1658 | Values: 69.0 71.0 119.0 71.0 72.0 111.0 113.0 69.0 74.0 130.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:81.50 stddev:20.75 (25.5%) stddev-sans-first:21.33 19:12:46 INFO - PROCESS | 1658 | Values: 88.0 78.0 135.0 127.0 88.0 85.0 88.0 101.0 108.0 128.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:96.00 stddev:21.67 (22.6%) stddev-sans-first:22.45 19:12:46 INFO - PROCESS | 1658 | Values: 97.0 151.0 119.0 99.0 96.0 96.0 98.0 106.0 147.0 94.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:115.30 Median:88.50 stddev:27.57 (31.2%) stddev-sans-first:27.21 19:12:46 INFO - PROCESS | 1658 | Values: 144.0 145.0 88.0 148.0 146.0 118.0 89.0 91.0 93.0 91.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:62.00 stddev:11.75 (19.0%) stddev-sans-first:11.99 19:12:46 INFO - PROCESS | 1658 | Values: 56.0 56.0 58.0 65.0 82.0 82.0 81.0 59.0 56.0 56.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:86.30 Median:73.50 stddev:18.82 (25.6%) stddev-sans-first:18.62 19:12:46 INFO - PROCESS | 1658 | Values: 67.0 75.0 89.0 59.0 97.0 114.0 107.0 105.0 78.0 72.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:84.50 stddev:6.19 (7.3%) stddev-sans-first:6.52 19:12:46 INFO - PROCESS | 1658 | Values: 84.0 83.0 82.0 87.0 81.0 88.0 85.0 88.0 81.0 102.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:148.00 stddev:31.15 (21.0%) stddev-sans-first:32.23 19:12:46 INFO - PROCESS | 1658 | Values: 135.0 139.0 145.0 150.0 147.0 145.0 151.0 149.0 242.0 142.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:169.50 stddev:19.46 (11.5%) stddev-sans-first:20.34 19:12:46 INFO - PROCESS | 1658 | Values: 166.0 171.0 167.0 170.0 169.0 164.0 163.0 162.0 202.0 220.0 19:12:46 INFO - PROCESS | 1658 | 19:12:46 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:2.58 (3.9%) stddev-sans-first:2.73 19:12:46 INFO - PROCESS | 1658 | Values: 67.0 66.0 71.0 65.0 69.0 64.0 64.0 64.0 69.0 64.0 19:12:46 INFO - PROCESS | 1658 | -------- Summary: end -------- 19:12:46 INFO - PROCESS | 1658 | 19:12:47 INFO - TEST-INFO | 1658: exit 0 19:12:47 INFO - TEST-OK | kraken | took 60869ms 19:12:47 INFO - SUITE-END | took 1173s 19:12:47 INFO - Completed test suite (00:19:34) 19:12:47 INFO - javascript benchmark 19:12:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7318.58459432381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2707.2419722477703, 3050.1764523578636, 3099.8295093769843, 3403.6085850127242, 3434.965650343496, 5684.118961560955, 5827.271591051119, 5887.85280367991, 5971.850703732409, 5971.970140149293, 4801.759912004394, 5595.944040559593, 5838.649681019142, 5889.676067816268, 5986.551008674345, 5207.062728708831, 5267.341582302212, 5357.303550538424, 5399.0, 5442.673439593617, 399.51829100512083, 5222.556082732972, 5246.449122842104, 5291.603129765283, 5293.232481290211, 4270.0, 5293.0, 5300.09898317285, 5342.813001544927, 5360.973195134019, 5325.760340784674, 5336.946630533684, 5352.170413585901, 5362.276092727471, 5392.110301800199, 5186.662866913676, 5198.4801519847715, 5256.6057545684225, 5263.0, 5288.180332048539, 5690.630109042941, 5856.882862342772, 5878.353381128072, 5883.794067207627, 5913.46778789911, 6111.572189946705, 6123.4351415035735, 6174.135621013017, 6181.227346581677, 6186.505079593621, 6148.600340977867, 6148.7087711580625, 6183.412575805336, 6236.345183755686, 6236.937630623726, 6004.909926351064, 6011.97796374613, 6013.849837557488, 6027.397260274025, 6061.878762424727, 6118.619179173164, 6319.115323854572, 6335.429811316912, 6383.744650214032, 6383.808485745435, 6134.681512609229, 6174.25908890927, 6175.752969881154, 6179.938200617937, 6203.0, 6175.62946223228, 6192.589637460765, 6260.718267677966, 6270.31026587075, 6271.43557079865, 6102.67103564696, 6108.190302030417, 6111.266648002179, 6161.784337548254, 6193.225846769154, 6091.939080609226, 6164.352742961924, 6168.907466388007, 6181.381861813873, 6198.938010619926, 5047.16721740916, 5062.544371006627, 5066.9359434519165, 5071.695698258042, 5099.082165210298, 4459.665525085632, 4463.575960283768, 4480.85738136773, 4515.751633660115, 4567.0, 5215.843524694265, 5472.288602481732, 5722.427757224327, 5906.173135760997, 5980.461758441761, 6213.2233470816145, 6247.031710084944, 6247.156633854463, 6271.247450305992, 6290.968545157245, 5775.133729940459, 5918.556108291896, 5956.434138756811, 5983.700814959235, 5989.460948514655, 5542.473465020817, 5560.332760068818, 5579.246801681802, 5593.188987596775, 5616.410276920865, 6496.155499784998, 6510.121133646897, 6515.73937042513, 6524.184476940382, 6549.901751473827, 6142.6314421134875, 6153.476954458921, 6180.598261113013, 6204.224471941007, 6211.3167551570195, 5463.508284254436, 6502.512311576556, 6514.837129071811, 6523.18460192476, 6531.967340163269, 5453.754581043783, 5550.66783971852, 6183.134361189347, 6187.041008643668, 6204.7828326008375, 5264.0, 6107.431569637723, 6136.427173609184, 6178.351273116258, 6240.656763878031, 5352.223927530408, 6125.632462052291, 6159.6612186330185, 6163.35284795108, 6170.228721409824, 5634.436556344497, 6148.4773794227995, 6159.5072394209255, 6170.568060235741, 6175.320714721287, 5974.880502390015, 6034.547408944259, 6039.305479869871, 6100.2984656763265, 6103.84740381494, 6144.815655530341, 6155.969220153871, 6164.260288765377, 6169.876602468015, 6172.537059720628, 5926.911096333472, 6041.909371359521, 6118.357572455006, 6124.479419249414, 6142.293636231891], "value": 5689.200931340737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.1824983653361, 543.6737957225664, 545.2285016701368, 564.6188822544781, 568.9829305120847, 38530.03674908125, 41345.379819302696, 41597.376039359435, 41624.37563436551, 41658.791706041426, 35946.460803087975, 42611.934701632475, 43432.782836085775, 43576.78211608945, 43611.0, 9504.857427138615, 9680.661176858812, 9691.660791872286, 9692.70921872345, 9727.951360243189, 9740.51297435129, 9814.92035876053, 9824.705258842247, 9871.950640246825, 9894.653687120952, 9772.706818795448, 9865.90134098657, 9872.062154095349, 9876.45679487628, 9877.357971731815, 8912.64349426022, 9423.539351400545, 9800.0, 9867.309288349818, 9896.257780666407, 9719.416834989923, 9793.559289831976, 9799.314048016571, 9816.509174541245, 9837.803243935154, 40537.0, 40863.18273634541, 40920.38619420711, 41029.97425064397, 41204.587954120376, 3246.2533617267923, 3446.293509830479, 3448.5689288838894, 3619.1133172372674, 3644.3804553226014, 27509.724902750917, 29157.54212289377, 30919.227019324473, 31138.377232455223, 31314.686853131407, 3074.907752767398, 3133.8903138390046, 3181.172895047281, 3190.0, 3277.246233366315, 447827.0, 457479.0, 530331.0, 533100.334498325, 536011.3199434017, 33604.0, 53563.928721425356, 65715.01427478592, 66140.66929665321, 66201.0, 28754.568681469795, 33987.83006084954, 34322.82838585791, 34437.65562344395, 34752.47871281933, 14517.0, 14557.490487832874, 14784.0, 15006.0, 15032.699346013018, 11482.138839586898, 12213.877861221452, 12680.80978785319, 12759.553415630407, 12782.424790884432, 7585.544867307979, 7643.923560764432, 7664.65509052094, 7679.76960691169, 7751.806204844924, 3208.4545627242956, 3220.500822372536, 3248.6588908164777, 3256.869725210965, 3285.950710739341, 940.9837375634298, 941.3551717073826, 946.0823001688351, 961.956711947964, 981.0, 29154.708452915198, 29507.262318442212, 29930.25174370658, 30211.395772084874, 30268.789248430257, 1106.468894930438, 1111.666500049998, 1112.7885701716648, 1122.5173175534599, 1180.3803003423272, 15989.440369587008, 16239.025658460294, 16325.612322952682, 16331.0, 16577.91711041461, 164577.17711411367, 165087.0, 166220.0, 543582.0, 544717.0, 57995.0, 58084.0, 58565.48607083588, 58619.70690146522, 58656.120158197664, 1350.2776014832018, 1410.9506167284096, 1416.0300194367098, 1423.1461123326128, 1423.5088894331438, 26127.38726127372, 29764.53531970135, 29908.252293692833, 30667.693323066484, 30905.518699787954, 44165.33751993787, 50775.49224507855, 50778.74610626923, 51141.0, 51258.48741512686, 451571.0, 468932.0, 469036.0, 469170.30829691264, 470047.0, 26796.732032679425, 26839.73160268372, 26936.865315673294, 27147.1855844325, 27158.592621110303, 48137.51862481471, 48314.516854831, 49000.50999489959, 49358.0, 49618.50381496139, 38837.41743873901, 40078.59921400749, 40265.79867100763, 40578.10835299867, 40594.391084133174, 39604.80197598993, 39907.60092399039, 40549.79725101356, 40665.0, 40742.0, 35412.64587354093, 37232.0, 38571.614283857925, 38595.03512412212, 39748.40377394284, 35400.645993539736, 35905.64094359023, 36237.91286261416, 36377.0, 36509.08727281839, 23585.0, 25969.831357588577, 25998.0, 26590.0, 26653.86673066622], "value": 18383.955674508812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3110434652427, 384.43680008787123, 386.80659670164937, 389.816786110528, 396.8075483390557, 19202.903985480072, 20838.687419688697, 20851.22764565014, 21155.788442115576, 21168.0, 17487.95072295663, 20147.0, 20755.584888302226, 21566.353009409704, 21647.0, 5729.971350143254, 5765.5099316557935, 5876.44173803488, 5885.117232415129, 5940.108983652443, 5591.6365436246715, 5807.9419205808035, 5814.866101110285, 5827.067669172933, 5840.445157710011, 5314.8838743863835, 5474.0, 5669.659820410768, 5758.884822303551, 5777.971110144444, 5104.902445974115, 5550.0, 5754.0, 5828.533717302648, 5845.85385365365, 4802.903941921177, 5047.64666473347, 5111.514406131449, 5119.385673719177, 5170.353705786777, 13238.874695650882, 13908.860911390959, 21424.035918383554, 24037.87981060101, 24865.005399783986, 1832.8808627439307, 2157.1048015073725, 2163.459135216196, 2275.7041584594062, 2278.100150440583, 10236.283460157792, 10265.897341026568, 11546.769064618744, 13309.933450332783, 14514.0, 1711.4181178399404, 1737.54823745827, 1779.2793918463044, 1854.8701590888643, 1880.652079365308, 112677.43661281723, 117288.82711172865, 126588.0, 130475.0, 130665.0, 11128.499217535069, 11493.080553555696, 11519.654410367702, 11530.423478826026, 11623.547056617923, 14470.565883023526, 14505.564833055025, 14597.41610335596, 14607.926960365343, 14608.9773715841, 8596.312295016383, 8659.307255419551, 8700.608472618747, 8704.956475217583, 8809.647614095493, 8811.867821982676, 8837.690680826141, 8860.512671802984, 8923.553822308859, 8964.238039766562, 4501.459824821042, 4515.412996310459, 4530.478994915627, 4558.840440584564, 4568.70303430276, 1621.4381277581392, 1958.0894883879064, 1960.3530834824473, 1961.7253584498183, 1966.9803301967083, 761.6344154805724, 865.6063737382808, 868.7046404222468, 915.6795121707349, 1035.7307100154014, 21564.568708626055, 21683.783162168493, 21684.02421891019, 21914.561708765734, 21919.890400548215, 941.4022095969109, 942.528735632184, 942.8962814090445, 943.6791490893129, 1022.2140700677663, 9925.30522863407, 10003.0, 10389.168866490663, 11205.887941120647, 11539.0, 242142.0, 244606.0, 244885.775571121, 465849.0, 618958.0, 124062.37968810098, 126446.10330845045, 126818.36590816987, 140431.29784351014, 145105.0, 762.904636920385, 844.0588743550896, 844.0673056272731, 844.6536919862826, 845.8266055458616, 17808.643827123644, 18345.72481412753, 19078.0, 19105.14026868822, 19211.135498902302, 37443.0, 54859.0, 57737.0, 57859.84280314286, 59051.0, 78699.6065019694, 85227.0, 85760.0, 86145.56927215324, 87982.1201787974, 7681.961590192013, 8075.636596353295, 8083.676652934052, 8287.709930152416, 8337.291330236998, 9164.175224229852, 10976.945115274373, 12123.878761212274, 13061.08572399961, 13335.866641333463, 9711.854322185314, 11409.0, 11473.685784491989, 11618.883811162119, 11643.825342620037, 10771.676849694522, 11421.31472111676, 11561.884381156417, 11567.325840234613, 11601.76796464049, 11024.338539687644, 11626.186166968231, 11632.53469861196, 11666.416679165837, 11733.413329333669, 8066.516009039477, 8138.83722325562, 8170.142135075732, 8277.0, 8281.509328320719, 8953.955230223808, 9717.0, 10740.71111466629, 11525.250858694159, 11657.650270491898], "value": 9336.453994548403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1561.5627624265203, 1597.5766421898197, 1836.4857839804852, 1914.100372824772, 1918.5779128591705, 8083.878741818878, 8618.267447266973, 8632.093630168836, 9180.8622870657, 9188.127127922846, 8700.695475658353, 8812.823743525125, 8878.467291962486, 8932.062133475989, 8942.59758310876, 2344.894479748411, 2360.858348499087, 2366.715994080704, 2368.3605426534828, 2386.319898828834, 2289.5192009677903, 2343.4492894169857, 2355.5053438777877, 2380.1550449590404, 2404.158544509425, 2348.495073559184, 2356.929292121239, 2363.5154793267425, 2364.9645255321184, 2365.89353479093, 2207.150247154841, 2210.613142700029, 2225.8664480131165, 2227.6992605998225, 2233.8659680419064, 2285.2801367569164, 2315.1896836107394, 2324.0819876148826, 2330.4639932815376, 2331.9650205246935, 8925.062868398854, 9007.324450666227, 9026.007139214682, 9045.909540904639, 9068.727938161866, 5154.793808247666, 5286.471352864722, 5309.0, 5309.707966061865, 5333.946660533384, 3339.2820543583002, 3410.7100896423835, 3485.9825700871334, 3576.910577235564, 3606.9819650901577, 1080.2438293194796, 1090.9672709818717, 1783.4025601423539, 1865.4496923407628, 1875.5873707784265, 11632.06943444531, 11655.358955257458, 11766.058715302755, 11797.88202117985, 11802.232854864405, 3903.375459926398, 4418.094290670405, 4478.417805685305, 4623.283391074388, 4631.328457373662, 9216.95391523038, 9281.21109705669, 9285.164335209864, 9287.582058807235, 9294.256459483226, 5175.585953123741, 5201.739913004335, 5205.141151709925, 5217.113090774577, 5217.608679349064, 4346.130773845243, 4759.262314341283, 4769.833055843029, 4882.853514394574, 4893.486183950705, 3783.0920579060826, 3813.7902415366866, 3857.672097871656, 3887.922241555153, 3924.156306394082, 1171.7363593191465, 1179.6932797472718, 1191.880811918801, 1194.8685644579089, 1205.3009254632293, 908.5956749246521, 918.5958178401482, 923.7275003873739, 947.1388721162948, 969.2698533118349, 5933.703314834241, 5995.760169593167, 5999.340072592011, 6072.210612620331, 6137.539684523589, 418.8806190235768, 426.86553735573193, 441.46582635011356, 446.54006373435413, 448.73524620474075, 3937.940930886039, 4070.3487442009136, 4075.5313138989395, 4078.632923036941, 4080.5307389649975, 10522.736931576772, 10941.890581094087, 10971.0, 11054.673439187349, 11054.944725276322, 10711.78576428467, 10742.3017503862, 10791.83812242817, 10885.727856803644, 10901.073408760345, 6620.106285651472, 7052.682629281695, 7718.768436946901, 8409.873851892227, 8423.410361274651, 5851.61964472308, 5946.316173640087, 5973.313068997121, 6082.665453399928, 6181.505479561534, 9663.661771837951, 10000.44997525114, 10137.746556336151, 10177.949110254698, 10201.897981020094, 8605.870911936201, 10215.02957219063, 10269.794604108025, 10297.3821570706, 10342.638007669997, 6644.302348253364, 7397.26027397256, 7417.1841097478155, 7444.367228785614, 7568.810779730551, 8529.82940341202, 8574.013988391414, 8608.65565377378, 8609.48343099416, 8611.569421529024, 7549.660265287966, 7726.227377262228, 7771.494852834548, 7784.727534536264, 7795.532268063935, 7449.180590134973, 7473.327400533978, 7522.172561018174, 7555.6977720890545, 7621.961890190513, 6994.125734283215, 7033.402160816388, 7075.964620177072, 7089.503734738725, 7147.0, 4874.2444921037295, 5067.543921047123, 5139.408967968731, 5147.6654017488745, 5161.948380516147, 5107.719075450886, 5136.717480538457, 5140.948590514047, 5293.629445938747, 5294.391145018372], "value": 4544.497632940909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.6596078353028, 310.86322018311944, 314.9795263307885, 315.3267773303995, 319.3564966592318, 5262.605514490911, 5730.56735816046, 5732.484076433126, 5778.393268706788, 5790.913136302948, 4898.657094003421, 5056.241563765428, 5580.330360356753, 5680.659160450376, 5686.488216060554, 3357.6474470180647, 4081.918291652722, 4170.040890595165, 4285.90709369112, 4329.406592528194, 3560.6973407260284, 4249.7476337541, 4282.828686852522, 4302.440682711243, 4329.372241025049, 3512.9297414051703, 4246.532881383061, 4264.296391095481, 4264.872053838374, 4282.635975942033, 4140.77225752585, 4264.658827293809, 4282.828686852522, 4289.24938135825, 4304.182205380999, 2884.754795842356, 3227.887023954174, 3702.8518859245596, 3711.3319602471543, 3725.0013738940143, 4475.955240447586, 5510.8071217507195, 5515.696636684981, 5524.447555244444, 5541.090927263179, 3827.291950989048, 3979.5025621797276, 4227.323628219501, 4959.70241785494, 4987.376577927759, 5196.791363670425, 5484.424135465799, 5636.605437619368, 5732.770689172428, 5891.582881928472, 3351.497275408684, 3983.960160398417, 4018.296798060357, 4024.436578878959, 4036.899077523056, 4774.0, 5730.713464326809, 5758.560359910022, 6282.623042617412, 6327.24073111225, 3592.8742494012586, 4198.517170525429, 4229.6827737919775, 4247.8088486018205, 4263.211305908417, 3944.8165550334784, 4073.837046518106, 4252.277112890754, 4255.446791917093, 4341.979634785823, 4676.321933319649, 4999.200127979506, 4999.325091112653, 5004.374453193351, 5022.723750193774, 5011.799528018912, 6096.110205836205, 6115.021596544531, 6118.816435506942, 6127.295361033449, 1458.8985316086287, 1475.6384685751846, 1475.7343678138038, 1477.0251633921775, 1479.5117611188282, 856.6787454704486, 903.96947479873, 907.7775944893543, 919.7332773495611, 920.8857282688023, 4256.212390795873, 4466.932996005063, 4866.902661946741, 5111.488851114858, 5551.666899986014, 5107.391171780877, 5718.71328950991, 6131.693415329216, 6138.508919286446, 6160.0, 4578.709734287931, 4665.9766701166955, 4682.792287283222, 5508.55931525477, 5532.589189756586, 2661.0021242034236, 3097.915729494659, 3179.5071763876635, 3232.5636039134415, 3250.837458127084, 4764.118638051971, 5564.8330550083565, 5922.466977972003, 6018.849528761816, 6307.653079080603, 5700.157338727837, 5902.527797776168, 5970.940290597126, 6220.7511699532415, 6354.491640668735, 6275.677999140347, 6299.488122850575, 6306.432421082125, 6335.384476958347, 6347.0, 5082.644214904921, 5755.280589926259, 5980.0, 6094.299155597163, 6133.325334213144, 5824.912626310694, 5905.675187864708, 6040.818775436744, 6051.515878729779, 6077.361877002851, 5625.549956003428, 5936.614120082181, 5970.611910225822, 6315.96842015787, 6320.62076275425, 3179.0, 3860.8841734748003, 4088.855120566246, 4183.602557757008, 4213.620774130343, 5525.811950430677, 5549.505989070872, 5651.378348381757, 6042.456178943916, 6132.233470816148, 5174.365384804663, 5474.589405794661, 5813.244278243801, 5888.054034610947, 5934.970325148347, 5201.687898726089, 5849.718609742119, 5914.201582786441, 5918.496927761188, 5934.881302374015, 5349.518543331119, 5532.889342213214, 5729.398413166724, 5777.24895763548, 5814.592978491465, 4951.9449428488215, 5612.7754889803955, 5959.3183067618875, 6036.517078633787, 6078.878422431439, 5850.356460789225, 5878.735456904364, 5894.498967587803, 5896.292444906639, 5951.821445356646], "value": 4277.014584452893, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.2297222374843, 752.5259086775334, 797.9162187970263, 814.3363159025394, 815.2744057788566, 15168.772468412968, 15762.054276743404, 15933.760993585076, 15934.521964341075, 15982.041077535341, 14371.281435928215, 14490.20303883286, 14502.347394367252, 14512.709745805078, 14513.854861451382, 704.264044073944, 871.2289623683023, 878.6573236437779, 900.3877363392891, 901.143913282381, 898.1243287794381, 898.6135961536537, 900.6442455230181, 908.8639200998751, 910.4309806371018, 945.1588086602928, 961.7980224152936, 962.8940816510213, 963.5471328475605, 964.9276304277172, 804.6419343392192, 949.1884438804791, 950.273041123541, 958.5111593087506, 959.3811991265629, 703.8521910398822, 705.1256442011919, 706.6855249414012, 707.4835370179746, 709.2977951827653, 15547.378104875905, 15572.143532105729, 15608.531744047697, 15673.686526269525, 15751.2124393781, 14878.70242595153, 14959.252037398086, 15005.69988600222, 15026.17356045417, 15217.847821521755, 12002.879971200351, 12206.389680515938, 12252.379343917004, 12466.937665311707, 12568.622941311774, 3883.475730776337, 3930.0, 4101.302778527627, 4125.66994640431, 4138.110306284163, 114968.0, 115508.0, 116051.77767000505, 116925.0, 117164.65670686538, 11393.487293071832, 11467.623885133671, 11550.537978480766, 11601.941990289995, 11655.30068195911, 20579.0, 24136.63795043076, 24292.271231863073, 24325.51348973046, 24613.507729845303, 7795.80510487231, 8013.519188848688, 8119.79700507492, 8222.13667564909, 8484.915150848536, 4479.977600111979, 4530.411046563926, 4591.334256532851, 4632.420947381577, 4662.6269898408045, 3592.8023958682525, 3996.86010989614, 4184.895377615584, 4187.727797693201, 4236.6187043166265, 730.4047201530735, 735.5917465806422, 739.8742213823663, 740.3558903753768, 748.4386709967524, 574.8304250246188, 636.312782195228, 664.2029564522592, 676.6988690032987, 683.6205905722372, 7897.24976127267, 8725.0, 9107.08929107084, 9350.786277688854, 9720.805583888283, 564.601955621286, 570.3925319534765, 618.7896115320813, 624.7688355308564, 662.2483481248818, 4702.4592171899985, 4768.356271903318, 4785.234362502053, 4804.915821551723, 4853.505778810898, 98867.0, 110014.44992774985, 149453.0, 153110.0, 157140.21429893005, 106744.46627766812, 107233.46383268034, 107552.0, 107823.0, 108502.3724644131, 118898.40550797191, 120408.5509738837, 120420.99999999825, 122994.15508767376, 125865.37067314606, 8832.337574682053, 9037.638494460149, 9097.454152750855, 9166.724998250063, 9198.954005230198, 59437.81124377402, 61278.38721612727, 63890.36109638844, 65874.0, 66866.99699504414, 70310.0, 96633.0336696624, 98391.95829188646, 100854.49572752089, 101770.0, 13614.659633509242, 14167.362468688727, 14298.999070064996, 14383.971291865862, 15218.086914785148, 15272.0, 15488.07071575709, 15502.457413990456, 15727.0, 16252.10613416226, 14187.64530886736, 14190.290485475478, 14441.205733684748, 14461.276936153361, 14661.413543458142, 14171.929140354232, 14258.429662813785, 14447.566573002827, 15066.020708653903, 15194.468193613171, 13722.794158087438, 14035.0, 14309.998300118892, 14459.493917712829, 14807.333669985092, 11198.608048718255, 11445.313281203154, 11450.37022963745, 11599.88400115988, 12074.335911524951, 10687.786244274916, 11042.33745975244, 11319.535889090346, 11491.770164596493, 11772.587959421722], "value": 8095.1071079808435, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1607.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 165.0, 107.0, 121.0, 97.0, 156.0, 162.0, 169.0, 116.0, 115.0], "value": 132.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 132.0, 160.0, 154.0, 111.0, 142.0, 129.0, 110.0, 190.0, 113.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 206.0, 240.0, 212.0, 198.0, 201.0, 200.0, 201.0, 201.0, 176.0], "value": 202.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 77.0, 146.0, 60.0, 58.0, 59.0, 64.0, 131.0, 61.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 119.0, 71.0, 72.0, 111.0, 113.0, 69.0, 74.0, 130.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 135.0, 127.0, 88.0, 85.0, 88.0, 101.0, 108.0, 128.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 151.0, 119.0, 99.0, 96.0, 96.0, 98.0, 106.0, 147.0, 94.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 88.0, 148.0, 146.0, 118.0, 89.0, 91.0, 93.0, 91.0], "value": 115.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 65.0, 82.0, 82.0, 81.0, 59.0, 56.0, 56.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 89.0, 59.0, 97.0, 114.0, 107.0, 105.0, 78.0, 72.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 87.0, 81.0, 88.0, 85.0, 88.0, 81.0, 102.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 145.0, 150.0, 147.0, 145.0, 151.0, 149.0, 242.0, 142.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 167.0, 170.0, 169.0, 164.0, 163.0, 162.0, 202.0, 220.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 71.0, 65.0, 69.0, 64.0, 64.0, 64.0, 69.0, 64.0], "value": 66.3, "unit": "score"}]}]} 19:12:47 INFO - Return code: 0 19:12:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:12:47 ERROR - # TBPL SUCCESS # 19:12:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:12:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:12:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:12:47 INFO - 2016-07-15 19:12:47.838 screenresolution[1663:10500] starting screenresolution argv=screenresolution get 19:12:47 INFO - 2016-07-15 19:12:47.841 screenresolution[1663:10500] Display 0: 1600x1200x32@60 19:12:47 INFO - 2016-07-15 19:12:47.847 screenresolution[1664:10503] starting screenresolution argv=screenresolution list 19:12:47 INFO - Available Modes on Display 0 19:12:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:12:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:12:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:12:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:12:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:12:48 INFO - Intel Iris: 19:12:48 INFO - Chipset Model: Intel Iris 19:12:48 INFO - Type: GPU 19:12:48 INFO - Bus: Built-In 19:12:48 INFO - VRAM (Dynamic, Max): 1536 MB 19:12:48 INFO - Vendor: Intel (0x8086) 19:12:48 INFO - Device ID: 0x0a2e 19:12:48 INFO - Revision ID: 0x0009 19:12:48 INFO - Displays: 19:12:48 INFO - Display: 19:12:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:12:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:12:48 INFO - Display Serial Number: 1600x1200 60 19:12:48 INFO - Main Display: Yes 19:12:48 INFO - Mirror: Off 19:12:48 INFO - Online: Yes 19:12:48 INFO - Rotation: Supported 19:12:48 INFO - Return code: 0 19:12:48 INFO - Running post-action listener: _resource_record_post_action 19:12:48 INFO - ##### 19:12:48 INFO - ##### Finished run-tests step (success) 19:12:48 INFO - ##### 19:12:48 INFO - Running post-run listener: _resource_record_post_run 19:12:48 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38143488; Write bytes: 708640768; Read time: 389; Write time: 3043 19:12:48 INFO - TinderboxPrint: CPU usage
54.4% 19:12:48 INFO - TinderboxPrint: I/O read bytes / time
38,143,488 / 389 19:12:48 INFO - TinderboxPrint: I/O write bytes / time
708,640,768 / 3,043 19:12:48 INFO - TinderboxPrint: CPU idle
2,204.6 (45.6%) 19:12:48 INFO - TinderboxPrint: CPU system
979.0 (20.2%) 19:12:48 INFO - TinderboxPrint: CPU user
1,654.1 (34.2%) 19:12:48 INFO - TinderboxPrint: Swap in / out
445,591,552 / 0 19:12:48 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 348160; Write bytes: 410925056; Read time: 8; Write time: 782 19:12:48 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 34493952; Write bytes: 296159232; Read time: 355; Write time: 2255 19:12:48 INFO - Running post-run listener: _upload_blobber_files 19:12:48 INFO - Blob upload gear active. 19:12:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:12:48 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 19:12:48 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'] 19:12:48 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 19:12:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:12:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:12:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:50 INFO - (blobuploader) - INFO - Done attempting. 19:12:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:12:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:12:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:51 INFO - (blobuploader) - INFO - Done attempting. 19:12:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:12:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:12:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:55 INFO - (blobuploader) - INFO - Done attempting. 19:12:55 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:55 INFO - Return code: 0 19:12:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:12:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:12:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82759e3059daaa1c34735fe5c776fbdbb5dfd55056540062d1936c3fee8f10e1ec86261e50c76e5c9f1dab4e937e4a520044bfbae4a89f955c8965f262747f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/863ec1229c11563b8dd317a6619ac3d285f78d79ee2811cb046a8b8f69c48489577d5651a7116b49b257630455dcc2ba03e29cedc3bbb3d3a5f74c20cc98469e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290cabe17bfd57ba1f75e72f44b21cdef12a6bee0c9804ee522234152347212432896978d093557a01852b5e077ccf988c8fdb7313904ac5a9d2bb7c4355388"} 19:12:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:12:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:12:55 INFO - Contents: 19:12:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82759e3059daaa1c34735fe5c776fbdbb5dfd55056540062d1936c3fee8f10e1ec86261e50c76e5c9f1dab4e937e4a520044bfbae4a89f955c8965f262747f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/863ec1229c11563b8dd317a6619ac3d285f78d79ee2811cb046a8b8f69c48489577d5651a7116b49b257630455dcc2ba03e29cedc3bbb3d3a5f74c20cc98469e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290cabe17bfd57ba1f75e72f44b21cdef12a6bee0c9804ee522234152347212432896978d093557a01852b5e077ccf988c8fdb7313904ac5a9d2bb7c4355388"} 19:12:55 INFO - Running post-run listener: copy_logs_to_upload_dir 19:12:55 INFO - Copying logs to upload dir... 19:12:55 INFO - mkdir: /builds/slave/test/build/upload/logs 19:12:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.027563 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-15 19:12:55.648842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 19:12:55.652123) ========= 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.8XSv766oPs/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.cdpjSgt5Kw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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/82759e3059daaa1c34735fe5c776fbdbb5dfd55056540062d1936c3fee8f10e1ec86261e50c76e5c9f1dab4e937e4a520044bfbae4a89f955c8965f262747f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/863ec1229c11563b8dd317a6619ac3d285f78d79ee2811cb046a8b8f69c48489577d5651a7116b49b257630455dcc2ba03e29cedc3bbb3d3a5f74c20cc98469e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290cabe17bfd57ba1f75e72f44b21cdef12a6bee0c9804ee522234152347212432896978d093557a01852b5e077ccf988c8fdb7313904ac5a9d2bb7c4355388"} build_url:https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/VXgp78UQTCW8wmikTOEZFw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82759e3059daaa1c34735fe5c776fbdbb5dfd55056540062d1936c3fee8f10e1ec86261e50c76e5c9f1dab4e937e4a520044bfbae4a89f955c8965f262747f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/863ec1229c11563b8dd317a6619ac3d285f78d79ee2811cb046a8b8f69c48489577d5651a7116b49b257630455dcc2ba03e29cedc3bbb3d3a5f74c20cc98469e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1290cabe17bfd57ba1f75e72f44b21cdef12a6bee0c9804ee522234152347212432896978d093557a01852b5e077ccf988c8fdb7313904ac5a9d2bb7c4355388"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 19:12:55.685512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 19:12:55.685900) ========= 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.8XSv766oPs/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.cdpjSgt5Kw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005116 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 19:12:55.734378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 19:12:55.734669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 19:12:55.734948) ========= ========= Total master_lag: 1.05 =========