builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0299 starttime: 1467272578.75 results: success (0) buildid: 20160629222829 builduid: 6da8f673e6ef4f329643d4ff76b42c75 revision: dc96e5ff02fd23198a2b7f7a4c93a86a77c760c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:58.746064) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:58.746475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:58.746779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:58.907431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:58.907728) ========= 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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-06-30 00:42:58-- 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% 154M=0s 2016-06-30 00:42:59 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.585164 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:59.517382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:59.517682) ========= 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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.019880 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:59.566532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 00:42:59.566905) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc96e5ff02fd23198a2b7f7a4c93a86a77c760c3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dc96e5ff02fd23198a2b7f7a4c93a86a77c760c3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rjrTjYqEIq/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.VUW5JK1Wte/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-06-30 00:42:59,650 truncating revision to first 12 chars 2016-06-30 00:42:59,650 Setting DEBUG logging. 2016-06-30 00:42:59,650 attempt 1/10 2016-06-30 00:42:59,650 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc96e5ff02fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 00:43:00,126 unpacking tar archive at: fx-team-dc96e5ff02fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744147 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 00:43:00.332782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 00:43:00.333281) ========= script_repo_revision: dc96e5ff02fd23198a2b7f7a4c93a86a77c760c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 00:43:00.333729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 00:43:00.334001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 00:43:00.352876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-06-30 00:43:00.353271) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rjrTjYqEIq/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.VUW5JK1Wte/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:43:00 INFO - MultiFileLogger online at 20160630 00:43:00 in /builds/slave/test 00:43:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:43:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:43:00 INFO - {'append_to_log': False, 00:43:00 INFO - 'base_work_dir': '/builds/slave/test', 00:43:00 INFO - 'blob_upload_branch': 'Fx-Team', 00:43:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:43:00 INFO - 'branch': 'Fx-Team', 00:43:00 INFO - 'buildbot_json_path': 'buildprops.json', 00:43:00 INFO - 'config_files': ('talos/mac_config.py',), 00:43:00 INFO - 'default_actions': ('clobber', 00:43:00 INFO - 'read-buildbot-config', 00:43:00 INFO - 'download-and-extract', 00:43:00 INFO - 'populate-webroot', 00:43:00 INFO - 'create-virtualenv', 00:43:00 INFO - 'install', 00:43:00 INFO - 'run-tests'), 00:43:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:43:00 INFO - 'download_minidump_stackwalk': True, 00:43:00 INFO - 'download_symbols': 'ondemand', 00:43:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:43:00 INFO - 'tooltool.py': '/tools/tooltool.py', 00:43:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:43:00 INFO - '/tools/misc-python/virtualenv.py')}, 00:43:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:43:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:43:00 INFO - 'installer_path': 'installer.exe', 00:43:00 INFO - 'log_level': 'info', 00:43:00 INFO - 'log_name': 'talos', 00:43:00 INFO - 'log_to_console': True, 00:43:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:43:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:43:00 INFO - 'opt_config_files': (), 00:43:00 INFO - 'pip_index': False, 00:43:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:43:00 INFO - 'cmd': ('bash', 00:43:00 INFO - '-c', 00:43:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:43:00 INFO - 'enabled': True, 00:43:00 INFO - 'halt_on_failure': False, 00:43:00 INFO - 'name': 'check_screen_resolution'},), 00:43:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:43:00 INFO - 'cmd': ('bash', 00:43:00 INFO - '-c', 00:43:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:43:00 INFO - 'enabled': True, 00:43:00 INFO - 'halt_on_failure': False, 00:43:00 INFO - 'name': 'check_screen_resolution'},), 00:43:00 INFO - 'run_cmd_checks_enabled': True, 00:43:00 INFO - 'sps_profile': False, 00:43:00 INFO - 'sps_profile_interval': 0, 00:43:00 INFO - 'suite': 'dromaeojs', 00:43:00 INFO - 'system_bits': '32', 00:43:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:43:00 INFO - 'title': 't-yosemite-r7-0299', 00:43:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:43:00 INFO - 'use_talos_json': True, 00:43:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:43:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:43:00 INFO - 'work_dir': 'build'} 00:43:00 INFO - ##### 00:43:00 INFO - ##### Running clobber step. 00:43:00 INFO - ##### 00:43:00 INFO - Running pre-action listener: _resource_record_pre_action 00:43:00 INFO - Running main action method: clobber 00:43:00 INFO - rmtree: /builds/slave/test/build 00:43:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:43:01 INFO - Running post-action listener: _resource_record_post_action 00:43:01 INFO - ##### 00:43:01 INFO - ##### Finished clobber step (success) 00:43:01 INFO - ##### 00:43:01 INFO - ##### 00:43:01 INFO - ##### Running read-buildbot-config step. 00:43:01 INFO - ##### 00:43:01 INFO - Running pre-action listener: _resource_record_pre_action 00:43:01 INFO - Running main action method: read_buildbot_config 00:43:01 INFO - Using buildbot properties: 00:43:01 INFO - { 00:43:01 INFO - "project": "", 00:43:01 INFO - "product": "firefox", 00:43:01 INFO - "script_repo_revision": "production", 00:43:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:43:01 INFO - "repository": "", 00:43:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:43:01 INFO - "buildid": "20160629222829", 00:43:01 INFO - "pgo_build": "False", 00:43:01 INFO - "basedir": "/builds/slave/test", 00:43:01 INFO - "buildnumber": 82, 00:43:01 INFO - "slavename": "t-yosemite-r7-0299", 00:43:01 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 00:43:01 INFO - "platform": "yosemite_r7", 00:43:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:43:01 INFO - "branch": "fx-team", 00:43:01 INFO - "repo_path": "integration/fx-team", 00:43:01 INFO - "revision": "dc96e5ff02fd23198a2b7f7a4c93a86a77c760c3", 00:43:01 INFO - "stage_platform": "macosx64", 00:43:01 INFO - "builduid": "6da8f673e6ef4f329643d4ff76b42c75", 00:43:01 INFO - "slavebuilddir": "test" 00:43:01 INFO - } 00:43:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 00:43:01 INFO - Running post-action listener: _resource_record_post_action 00:43:01 INFO - ##### 00:43:01 INFO - ##### Finished read-buildbot-config step (success) 00:43:01 INFO - ##### 00:43:01 INFO - ##### 00:43:01 INFO - ##### Running download-and-extract step. 00:43:01 INFO - ##### 00:43:01 INFO - Running pre-action listener: _resource_record_pre_action 00:43:01 INFO - Running main action method: download_and_extract 00:43:01 INFO - mkdir: /builds/slave/test/build/tests 00:43: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')]} 00:43:01 INFO - https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 00:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 00:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 00:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:06 INFO - Downloaded 1199 bytes. 00:43:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 00:43:06 INFO - Using the following test package requirements: 00:43:06 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 00:43:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 00:43:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 00:43:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'jsshell-mac.zip'], 00:43:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 00:43:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 00:43:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 00:43:06 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 00:43:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 00:43:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:43:06 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 00:43:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:43:06 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')]} 00:43:06 INFO - https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:43:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:43:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:43:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:08 INFO - Downloaded 18788557 bytes. 00:43:08 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'] 00:43:08 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 00:43:11 INFO - Return code: 0 00:43:11 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 00:43: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')]} 00:43:11 INFO - https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:43:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:43:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:43:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:22 INFO - Downloaded 18788557 bytes. 00:43:22 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'] 00:43:22 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 00:43:25 INFO - Return code: 0 00:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:25 INFO - https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 00:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 00:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:27 INFO - Downloaded 14405245 bytes. 00:43:27 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'] 00:43:27 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 00:43:27 INFO - Return code: 0 00:43: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')]} 00:43:27 INFO - https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 00:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CARRk6cjTuy3Q94L49YLFQ/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 00:43:39 INFO - Downloaded 112468727 bytes. 00:43:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:43:39 INFO - mkdir: /builds/slave/test/properties 00:43:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:43:39 INFO - Writing to file /builds/slave/test/properties/build_url 00:43:39 INFO - Contents: 00:43:39 INFO - build_url:https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:43:40 INFO - Running post-action listener: _resource_record_post_action 00:43:40 INFO - Running post-action listener: set_extra_try_arguments 00:43:40 INFO - ##### 00:43:40 INFO - ##### Finished download-and-extract step (success) 00:43:40 INFO - ##### 00:43:40 INFO - ##### 00:43:40 INFO - ##### Running populate-webroot step. 00:43:40 INFO - ##### 00:43:40 INFO - Running pre-action listener: _resource_record_pre_action 00:43:40 INFO - Running main action method: populate_webroot 00:43:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:43:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:43:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:43:40 INFO - '--tppagecycles', 00:43:40 INFO - '7'], 00:43:40 INFO - 'tests': ['tsvgm']}}, 00:43:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:43:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:43:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:43:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:43:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:43:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:43:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['damp', 'tps']}, 00:43:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'tests': ['damp', 'tps']}, 00:43:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['dromaeo_dom']}, 00:43:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:43:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['basic_compositor_video']}, 00:43:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:43:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['a11yr', 00:43:40 INFO - 'ts_paint', 00:43:40 INFO - 'tpaint', 00:43:40 INFO - 'sessionrestore', 00:43:40 INFO - 'sessionrestore_no_auto_restore', 00:43:40 INFO - 'tabpaint']}, 00:43:40 INFO - 'other-e10s': {'tests': ['a11yr', 00:43:40 INFO - 'ts_paint', 00:43:40 INFO - 'tpaint', 00:43:40 INFO - 'sessionrestore', 00:43:40 INFO - 'sessionrestore_no_auto_restore', 00:43:40 INFO - 'tabpaint']}, 00:43:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:43:40 INFO - 'ts_paint', 00:43:40 INFO - 'tpaint', 00:43:40 INFO - 'sessionrestore', 00:43:40 INFO - 'sessionrestore_no_auto_restore', 00:43:40 INFO - 'tabpaint']}, 00:43:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:43:40 INFO - 'ts_paint', 00:43:40 INFO - 'tpaint', 00:43:40 INFO - 'sessionrestore', 00:43:40 INFO - 'sessionrestore_no_auto_restore', 00:43:40 INFO - 'tabpaint']}, 00:43:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['a11yr', 00:43:40 INFO - 'ts_paint', 00:43:40 INFO - 'tpaint', 00:43:40 INFO - 'sessionrestore', 00:43:40 INFO - 'sessionrestore_no_auto_restore', 00:43:40 INFO - 'tabpaint']}, 00:43:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['a11yr', 00:43:40 INFO - 'ts_paint', 00:43:40 INFO - 'tpaint', 00:43:40 INFO - 'sessionrestore', 00:43:40 INFO - 'sessionrestore_no_auto_restore', 00:43:40 INFO - 'tabpaint']}, 00:43:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['tsvgx', 00:43:40 INFO - 'tsvgr_opacity', 00:43:40 INFO - 'tart', 00:43:40 INFO - 'tscrollx', 00:43:40 INFO - 'cart']}, 00:43:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:43:40 INFO - 'tsvgr_opacity', 00:43:40 INFO - 'tart', 00:43:40 INFO - 'tscrollx', 00:43:40 INFO - 'cart']}, 00:43:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'talos_options': ['--disable-e10s'], 00:43:40 INFO - 'tests': ['tp5o']}, 00:43:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'tests': ['tp5o']}, 00:43:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'talos_options': ['--disable-e10s', 00:43:40 INFO - '--xperf_path', 00:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:43:40 INFO - 'tests': ['tp5n']}, 00:43:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:43:40 INFO - 'talos_options': ['--xperf_path', 00:43:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:43:40 INFO - 'tests': ['tp5n']}}, 00:43:40 INFO - 'talos.zip': {'path': '', 00:43:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:43:40 INFO - Running post-action listener: _resource_record_post_action 00:43:40 INFO - ##### 00:43:40 INFO - ##### Finished populate-webroot step (success) 00:43:40 INFO - ##### 00:43:40 INFO - ##### 00:43:40 INFO - ##### Running create-virtualenv step. 00:43:40 INFO - ##### 00:43:40 INFO - Running pre-action listener: _resource_record_pre_action 00:43:40 INFO - Running main action method: create_virtualenv 00:43:40 INFO - Creating virtualenv /builds/slave/test/build/venv 00:43:40 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 00:43:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:43:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:43:40 INFO - Using real prefix '/tools/python27' 00:43:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:43:41 INFO - Installing distribute.............................................................................................................................................................................................done. 00:43:44 INFO - Installing pip.................done. 00:43:44 INFO - Return code: 0 00:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:44 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:43:44 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 00:43:44 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 00:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:43:44 INFO - 'HOME': '/Users/cltbld', 00:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:43:44 INFO - 'LOGNAME': 'cltbld', 00:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:43:44 INFO - 'MOZ_NO_REMOTE': '1', 00:43:44 INFO - 'NO_EM_RESTART': '1', 00:43:44 INFO - 'PAGER': '/bin/cat', 00:43:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:43:44 INFO - 'PWD': '/builds/slave/test', 00:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:43:44 INFO - 'SHELL': '/bin/bash', 00:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:43:44 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:43:44 INFO - 'USER': 'cltbld', 00:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:43:44 INFO - 'XPC_FLAGS': '0x0', 00:43:44 INFO - 'XPC_SERVICE_NAME': '0', 00:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:43:44 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 00:43:44 INFO - Cleaning up... 00:43:44 INFO - Return code: 0 00:43:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:44 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:43:44 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 00:43:44 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 00:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:43:44 INFO - 'HOME': '/Users/cltbld', 00:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:43:44 INFO - 'LOGNAME': 'cltbld', 00:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:43:44 INFO - 'MOZ_NO_REMOTE': '1', 00:43:44 INFO - 'NO_EM_RESTART': '1', 00:43:44 INFO - 'PAGER': '/bin/cat', 00:43:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:43:44 INFO - 'PWD': '/builds/slave/test', 00:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:43:44 INFO - 'SHELL': '/bin/bash', 00:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:43:44 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:43:44 INFO - 'USER': 'cltbld', 00:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:43:44 INFO - 'XPC_FLAGS': '0x0', 00:43:44 INFO - 'XPC_SERVICE_NAME': '0', 00:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:43:44 INFO - Downloading/unpacking psutil>=3.1.1 00:43:44 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 00:43:44 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 00:43:44 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 00:43:44 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 00:43:44 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 00:43:44 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 00:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:43:47 INFO - Installing collected packages: psutil 00:43:47 INFO - Running setup.py install for psutil 00:43:47 INFO - building 'psutil._psutil_osx' extension 00:43:47 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 00:43:48 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 00:43:48 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 00:43:48 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 00:43:48 INFO - building 'psutil._psutil_posix' extension 00:43:48 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 00:43:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:43:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:43:48 INFO - ^ 00:43:48 INFO - 1 warning generated. 00:43:48 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 00:43:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:43:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:43:48 INFO - Successfully installed psutil 00:43:48 INFO - Cleaning up... 00:43:48 INFO - Return code: 0 00:43:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:43:48 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')]} 00:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:48 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')]} 00:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:48 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:43:48 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 00:43:48 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 00:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:43:48 INFO - 'HOME': '/Users/cltbld', 00:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:43:48 INFO - 'LOGNAME': 'cltbld', 00:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:43:48 INFO - 'MOZ_NO_REMOTE': '1', 00:43:48 INFO - 'NO_EM_RESTART': '1', 00:43:48 INFO - 'PAGER': '/bin/cat', 00:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:43:48 INFO - 'PWD': '/builds/slave/test', 00:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:43:48 INFO - 'SHELL': '/bin/bash', 00:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:43:48 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:43:48 INFO - 'USER': 'cltbld', 00:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:43:48 INFO - 'XPC_FLAGS': '0x0', 00:43:48 INFO - 'XPC_SERVICE_NAME': '0', 00:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:43:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:43:48 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 00:43:48 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 00:43:48 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 00:43:48 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 00:43:48 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 00:43:48 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 00:43:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:43:51 INFO - Installing collected packages: mozsystemmonitor 00:43:51 INFO - Running setup.py install for mozsystemmonitor 00:43:51 INFO - Successfully installed mozsystemmonitor 00:43:51 INFO - Cleaning up... 00:43:51 INFO - Return code: 0 00:43:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:51 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:43:51 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 00:43:51 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 00:43:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:43:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:43:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:43:51 INFO - 'HOME': '/Users/cltbld', 00:43:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:43:51 INFO - 'LOGNAME': 'cltbld', 00:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:43:51 INFO - 'MOZ_NO_REMOTE': '1', 00:43:51 INFO - 'NO_EM_RESTART': '1', 00:43:51 INFO - 'PAGER': '/bin/cat', 00:43:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:43:51 INFO - 'PWD': '/builds/slave/test', 00:43:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:43:51 INFO - 'SHELL': '/bin/bash', 00:43:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:43:51 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:43:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:43:51 INFO - 'USER': 'cltbld', 00:43:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:43:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:43:51 INFO - 'XPC_FLAGS': '0x0', 00:43:51 INFO - 'XPC_SERVICE_NAME': '0', 00:43:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:43:51 INFO - Downloading/unpacking jsonschema==2.5.1 00:43:51 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 00:43:51 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 00:43:51 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 00:43:51 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 00:43:51 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 00:43:51 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 00:43:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:43:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:43:54 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 00:43:54 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 00:43:54 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 00:43:54 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 00:43:54 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 00:43:54 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 00:43:54 INFO - Downloading functools32-3.2.3-2.tar.gz 00:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:43:54 INFO - warning: no files found matching '*.txt' 00:43:54 INFO - no previously-included directories found matching 'build' 00:43:54 INFO - no previously-included directories found matching 'dist' 00:43:54 INFO - no previously-included directories found matching '.git*' 00:43:54 INFO - Installing collected packages: jsonschema, functools32 00:43:54 INFO - Running setup.py install for functools32 00:43:54 INFO - warning: no files found matching '*.txt' 00:43:54 INFO - no previously-included directories found matching 'build' 00:43:54 INFO - no previously-included directories found matching 'dist' 00:43:54 INFO - no previously-included directories found matching '.git*' 00:43:54 INFO - Successfully installed jsonschema functools32 00:43:54 INFO - Cleaning up... 00:43:55 INFO - Return code: 0 00:43:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:43:55 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:43:55 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 00:43:55 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 00:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:43:55 INFO - 'HOME': '/Users/cltbld', 00:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:43:55 INFO - 'LOGNAME': 'cltbld', 00:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:43:55 INFO - 'MOZ_NO_REMOTE': '1', 00:43:55 INFO - 'NO_EM_RESTART': '1', 00:43:55 INFO - 'PAGER': '/bin/cat', 00:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:43:55 INFO - 'PWD': '/builds/slave/test', 00:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:43:55 INFO - 'SHELL': '/bin/bash', 00:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:43:55 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:43:55 INFO - 'USER': 'cltbld', 00:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:43:55 INFO - 'XPC_FLAGS': '0x0', 00:43:55 INFO - 'XPC_SERVICE_NAME': '0', 00:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:43:55 INFO - Downloading/unpacking blobuploader==1.2.4 00:43:55 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 00:43:55 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 00:43:55 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 00:43:55 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 00:43:55 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 00:43:55 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 00:43:57 INFO - Downloading blobuploader-1.2.4.tar.gz 00:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:43:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:43:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:43:58 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 00:43:58 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 00:43:58 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 00:43:58 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 00:43:58 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 00:43:58 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 00:43:59 INFO - Downloading docopt-0.6.1.tar.gz 00:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:43:59 INFO - Installing collected packages: blobuploader, requests, docopt 00:43:59 INFO - Running setup.py install for blobuploader 00:43:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:43:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:43:59 INFO - Running setup.py install for requests 00:43:59 INFO - Running setup.py install for docopt 00:43:59 INFO - Successfully installed blobuploader requests docopt 00:43:59 INFO - Cleaning up... 00:44:00 INFO - Return code: 0 00:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:00 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:44:00 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 00:44:00 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 00:44:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:44:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:44:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:44:00 INFO - 'HOME': '/Users/cltbld', 00:44:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:44:00 INFO - 'LOGNAME': 'cltbld', 00:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:44:00 INFO - 'MOZ_NO_REMOTE': '1', 00:44:00 INFO - 'NO_EM_RESTART': '1', 00:44:00 INFO - 'PAGER': '/bin/cat', 00:44:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:44:00 INFO - 'PWD': '/builds/slave/test', 00:44:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:44:00 INFO - 'SHELL': '/bin/bash', 00:44:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:44:00 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:44:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:44:00 INFO - 'USER': 'cltbld', 00:44:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:44:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:44:00 INFO - 'XPC_FLAGS': '0x0', 00:44:00 INFO - 'XPC_SERVICE_NAME': '0', 00:44:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:44:00 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-sYdfIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:44:00 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-5fP7JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:44:00 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-IfV_hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:44:00 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-l8kkW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:44:00 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-2yeFRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:44:00 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-0YKnLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:44:00 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-mg0Otg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9pnxZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-MVveDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-jdIfDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-CXYFbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-3huI5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-x5De9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-MpUv17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-U_zRTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-afJKMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:44:01 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-0PcFmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:44:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:44:02 INFO - Running setup.py install for manifestparser 00:44:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:44:02 INFO - Running setup.py install for mozcrash 00:44:02 INFO - Running setup.py install for mozdebug 00:44:02 INFO - Running setup.py install for mozdevice 00:44:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:44:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:44:02 INFO - Running setup.py install for mozfile 00:44:02 INFO - Running setup.py install for mozhttpd 00:44:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:44:02 INFO - Running setup.py install for mozinfo 00:44:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:44:03 INFO - Running setup.py install for mozInstall 00:44:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:44:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:44:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:44:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:44:03 INFO - Running setup.py install for mozleak 00:44:03 INFO - Running setup.py install for mozlog 00:44:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:44:03 INFO - Running setup.py install for moznetwork 00:44:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:44:03 INFO - Running setup.py install for mozprocess 00:44:03 INFO - Running setup.py install for mozprofile 00:44:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:44:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:44:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:44:04 INFO - Running setup.py install for mozrunner 00:44:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:44:04 INFO - Running setup.py install for mozscreenshot 00:44:04 INFO - Running setup.py install for moztest 00:44:04 INFO - Running setup.py install for mozversion 00:44:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:44:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:44:04 INFO - Cleaning up... 00:44:04 INFO - Return code: 0 00:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:04 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:44:04 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 00:44:04 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 00:44:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:44:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:44:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:44:04 INFO - 'HOME': '/Users/cltbld', 00:44:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:44:04 INFO - 'LOGNAME': 'cltbld', 00:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:44:04 INFO - 'MOZ_NO_REMOTE': '1', 00:44:04 INFO - 'NO_EM_RESTART': '1', 00:44:04 INFO - 'PAGER': '/bin/cat', 00:44:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:44:04 INFO - 'PWD': '/builds/slave/test', 00:44:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:44:04 INFO - 'SHELL': '/bin/bash', 00:44:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:44:04 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:44:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:44:04 INFO - 'USER': 'cltbld', 00:44:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:44:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:44:04 INFO - 'XPC_FLAGS': '0x0', 00:44:04 INFO - 'XPC_SERVICE_NAME': '0', 00:44:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:44:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-oYo3Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:44:05 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)) 00:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:44:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-fq37CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:44:05 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)) 00:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:44:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-QGJGF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:44:05 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)) 00:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:44:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-lqIFFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:44:05 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)) 00:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:44:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-o6iYBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:44:05 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)) 00:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:44:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-GKul6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:44:05 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)) 00:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:44:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-f231QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-afGrhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-MTbwDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-_do5zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-sQ6Zkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-F9y_bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-eyodXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xDutie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-aB60rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:44:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-rLVipc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:44:06 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)) 00:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:44:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-qEqdgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:44:07 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)) 00:44:07 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)) 00:44:07 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)) 00:44:07 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)) 00:44:07 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)) 00:44:07 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)) 00:44:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:44:09 INFO - Downloading blessings-1.6.tar.gz 00:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:44:10 INFO - Installing collected packages: blessings 00:44:10 INFO - Running setup.py install for blessings 00:44:10 INFO - Successfully installed blessings 00:44:10 INFO - Cleaning up... 00:44:10 INFO - Return code: 0 00:44:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:44:10 INFO - Reading from file tmpfile_stdout 00:44:10 INFO - Current package versions: 00:44:10 INFO - blessings == 1.6 00:44:10 INFO - blobuploader == 1.2.4 00:44:10 INFO - docopt == 0.6.1 00:44:10 INFO - functools32 == 3.2.3-2 00:44:10 INFO - jsonschema == 2.5.1 00:44:10 INFO - manifestparser == 1.1 00:44:10 INFO - mozInstall == 1.12 00:44:10 INFO - mozcrash == 0.17 00:44:10 INFO - mozdebug == 0.1 00:44:10 INFO - mozdevice == 0.48 00:44:10 INFO - mozfile == 1.2 00:44:10 INFO - mozhttpd == 0.7 00:44:10 INFO - mozinfo == 0.9 00:44:10 INFO - mozleak == 0.1 00:44:10 INFO - mozlog == 3.2 00:44:10 INFO - moznetwork == 0.27 00:44:10 INFO - mozprocess == 0.22 00:44:10 INFO - mozprofile == 0.28 00:44:10 INFO - mozrunner == 6.11 00:44:10 INFO - mozscreenshot == 0.1 00:44:10 INFO - mozsystemmonitor == 0.3 00:44:10 INFO - moztest == 0.7 00:44:10 INFO - mozversion == 1.4 00:44:10 INFO - psutil == 3.1.1 00:44:10 INFO - requests == 1.2.3 00:44:10 INFO - wsgiref == 0.1.2 00:44:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:10 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:44:10 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 00:44:10 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 00:44:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:44:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:44:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:44:10 INFO - 'HOME': '/Users/cltbld', 00:44:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:44:10 INFO - 'LOGNAME': 'cltbld', 00:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:44:10 INFO - 'MOZ_NO_REMOTE': '1', 00:44:10 INFO - 'NO_EM_RESTART': '1', 00:44:10 INFO - 'PAGER': '/bin/cat', 00:44:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:44:10 INFO - 'PWD': '/builds/slave/test', 00:44:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:44:10 INFO - 'SHELL': '/bin/bash', 00:44:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:44:10 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:44:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:44:10 INFO - 'USER': 'cltbld', 00:44:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:44:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:44:10 INFO - 'XPC_FLAGS': '0x0', 00:44:10 INFO - 'XPC_SERVICE_NAME': '0', 00:44:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 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)) 00:44:10 INFO - Cleaning up... 00:44:10 INFO - Return code: 0 00:44:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:44:10 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 0x10ef16a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b9d84810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, '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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 00:44:10 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 00:44:10 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 00:44:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:44:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:44:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:44:10 INFO - 'HOME': '/Users/cltbld', 00:44:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:44:10 INFO - 'LOGNAME': 'cltbld', 00:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:44:10 INFO - 'MOZ_NO_REMOTE': '1', 00:44:10 INFO - 'NO_EM_RESTART': '1', 00:44:10 INFO - 'PAGER': '/bin/cat', 00:44:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:44:10 INFO - 'PWD': '/builds/slave/test', 00:44:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:44:10 INFO - 'SHELL': '/bin/bash', 00:44:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:44:10 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:44:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:44:10 INFO - 'USER': 'cltbld', 00:44:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:44:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:44:10 INFO - 'XPC_FLAGS': '0x0', 00:44:10 INFO - 'XPC_SERVICE_NAME': '0', 00:44:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:44:11 INFO - Cleaning up... 00:44:11 INFO - Return code: 0 00:44:11 INFO - Running post-action listener: _resource_record_post_action 00:44:11 INFO - Running post-action listener: _start_resource_monitoring 00:44:11 INFO - Starting resource monitoring. 00:44:11 INFO - ##### 00:44:11 INFO - ##### Finished create-virtualenv step (success) 00:44:11 INFO - ##### 00:44:11 INFO - ##### 00:44:11 INFO - ##### Running install step. 00:44:11 INFO - ##### 00:44:11 INFO - Running pre-action listener: _resource_record_pre_action 00:44:11 INFO - Running main action method: install 00:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:44:11 INFO - Reading from file tmpfile_stdout 00:44:11 INFO - Detecting whether we're running mozinstall >=1.0... 00:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:44:11 INFO - Reading from file tmpfile_stdout 00:44:11 INFO - Output received: 00:44:11 INFO - Usage: mozinstall [options] installer 00:44:11 INFO - Options: 00:44:11 INFO - -h, --help show this help message and exit 00:44:11 INFO - -d DEST, --destination=DEST 00:44:11 INFO - Directory to install application into. [default: 00:44:11 INFO - "/builds/slave/test"] 00:44:11 INFO - --app=APP Application being installed. [default: firefox] 00:44:11 INFO - mkdir: /builds/slave/test/build/application 00:44:11 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'] 00:44:11 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 00:44:45 INFO - Reading from file tmpfile_stdout 00:44:45 INFO - Output received: 00:44:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:44:45 INFO - Running post-action listener: _resource_record_post_action 00:44:45 INFO - ##### 00:44:45 INFO - ##### Finished install step (success) 00:44:45 INFO - ##### 00:44:45 INFO - ##### 00:44:45 INFO - ##### Running run-tests step. 00:44:45 INFO - ##### 00:44:45 INFO - Running pre-action listener: _resource_record_pre_action 00:44:45 INFO - Running main action method: run_tests 00:44:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:44:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:44:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:44:45 INFO - 2016-06-30 00:44:45.523 screenresolution[1936:17645] starting screenresolution argv=screenresolution get 00:44:45 INFO - 2016-06-30 00:44:45.526 screenresolution[1936:17645] Display 0: 1600x1200x32@60 00:44:45 INFO - 2016-06-30 00:44:45.532 screenresolution[1937:17647] starting screenresolution argv=screenresolution list 00:44:45 INFO - Available Modes on Display 0 00:44:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:44:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:44:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:44:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:44:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:44:45 INFO - Intel Iris: 00:44:45 INFO - Chipset Model: Intel Iris 00:44:45 INFO - Type: GPU 00:44:45 INFO - Bus: Built-In 00:44:45 INFO - VRAM (Dynamic, Max): 1536 MB 00:44:45 INFO - Vendor: Intel (0x8086) 00:44:45 INFO - Device ID: 0x0a2e 00:44:45 INFO - Revision ID: 0x0009 00:44:45 INFO - Displays: 00:44:45 INFO - Display: 00:44:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:44:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:44:45 INFO - Display Serial Number: 1600x1200 60 00:44:45 INFO - Main Display: Yes 00:44:45 INFO - Mirror: Off 00:44:45 INFO - Online: Yes 00:44:45 INFO - Rotation: Supported 00:44:45 INFO - Return code: 0 00:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:44:45 INFO - Python 2.7.3 00:44:45 INFO - Return code: 0 00:44:45 INFO - grabbing minidump binary from tooltool 00:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:44:45 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 0x10ee7ad30>, '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 0x10ebdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee72b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:44:45 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 00:44:45 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 00:44:45 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 00:44:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:44:45 INFO - Return code: 0 00:44:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:44:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:44:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:44:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:44:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0299 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:44:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rjrTjYqEIq/Render', 00:44:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:44:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:44:45 INFO - 'HOME': '/Users/cltbld', 00:44:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:44:45 INFO - 'LOGNAME': 'cltbld', 00:44:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:44:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:44:45 INFO - 'MOZ_NO_REMOTE': '1', 00:44:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:44:45 INFO - 'NO_EM_RESTART': '1', 00:44:45 INFO - 'PAGER': '/bin/cat', 00:44:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:44:45 INFO - 'PWD': '/builds/slave/test', 00:44:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:44:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:44:45 INFO - 'SHELL': '/bin/bash', 00:44:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUW5JK1Wte/Listeners', 00:44:45 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 00:44:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:44:45 INFO - 'USER': 'cltbld', 00:44:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:44:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:44:45 INFO - 'XPC_FLAGS': '0x0', 00:44:45 INFO - 'XPC_SERVICE_NAME': '0', 00:44:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:44:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:44:46 INFO - mozversion application_buildid: 20160629222829 00:44:46 INFO - mozversion application_changeset: dc96e5ff02fd23198a2b7f7a4c93a86a77c760c3 00:44:46 INFO - mozversion application_display_name: Nightly 00:44:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:44:46 INFO - mozversion application_name: Firefox 00:44:46 INFO - mozversion application_remotingname: firefox 00:44:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:44:46 INFO - mozversion application_vendor: Mozilla 00:44:46 INFO - mozversion application_version: 50.0a1 00:44:46 INFO - mozversion platform_buildid: 20160629222829 00:44:46 INFO - mozversion platform_changeset: dc96e5ff02fd23198a2b7f7a4c93a86a77c760c3 00:44:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:44:46 INFO - mozversion platform_version: 50.0a1 00:44:46 INFO - using testdate: 1467272686 00:44:46 INFO - actual date: 1467272686 00:44:46 INFO - starting webserver on 'localhost:52302' 00:44:46 INFO - SUITE-START | Running 2 tests 00:44:46 INFO - TEST-START | dromaeo_css 00:44:46 INFO - operating with platform_type : mac_ 00:44:46 INFO - Initialising browser for dromaeo_css test... 00:44:46 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpm1JkQ7/profile http://localhost:52302/getInfo.html) 00:44:48 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 00:44:48 INFO - PROCESS | 1947 | colorDepth:24 00:44:48 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 00:44:48 INFO - PROCESS | 1947 | __metrics 00:44:48 INFO - PROCESS | 1947 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:44:48 INFO - PROCESS | 1947 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:44:49 INFO - TEST-INFO | 1947: exit 0 00:44:49 INFO - Browser initialized. 00:44:49 INFO - Running cycle 1/1 for dromaeo_css test... 00:44:49 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpm1JkQ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:45:01 INFO - PROCESS | 1949 | RSS: Main: 243867648 00:45:01 INFO - PROCESS | 1949 | 00:45:52 INFO - PROCESS | 1949 | 1467272752819 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] 00:48:03 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:52302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52302/tests/dromaeo/cssquery-ext.html) 00:48:04 INFO - PROCESS | 1949 | RSS: Main: 372289536 00:48:04 INFO - PROCESS | 1949 | 00:51:07 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:52302/tests/dromaeo/cssquery-ext.html (next: http://localhost:52302/tests/dromaeo/cssquery-jquery.html) 00:51:08 INFO - PROCESS | 1949 | RSS: Main: 371838976 00:51:08 INFO - PROCESS | 1949 | 00:54:10 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:52302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52302/tests/dromaeo/cssquery-mootools.html) 00:54:11 INFO - PROCESS | 1949 | RSS: Main: 371884032 00:54:11 INFO - PROCESS | 1949 | 00:57:13 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:52302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52302/tests/dromaeo/cssquery-prototype.html) 00:57:14 INFO - PROCESS | 1949 | RSS: Main: 371122176 00:57:14 INFO - PROCESS | 1949 | 01:00:17 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:52302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52302/tests/dromaeo/cssquery-yui.html) 01:00:18 INFO - PROCESS | 1949 | RSS: Main: 335294464 01:00:18 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:52302/tests/dromaeo/cssquery-yui.html (next: http://localhost:52302/tests/dromaeo/cssquery-dojo.html) 01:03:21 INFO - PROCESS | 1949 | RSS: Main: 386125824 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | __start_tp_report 01:03:21 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 01:03:21 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 01:03:21 INFO - PROCESS | 1949 | |i|pagename|runs| 01:03:21 INFO - PROCESS | 1949 | |0;dojo.html;3375.6961873431387;3375.7130643895266;3378.30744697337;3390.9830450847735;3432;5626.324841019084;5652.09566469365;5729.312482502095;5737.454941780529;5759.366469688336;5747.281589801275;5770.740316685748;5772.5670574706955;5781.017227071397;5781.595288329819;5177.171652535595;5206.973965130169;5210;5229.50319719626;5290.100682883919;5260.868478288055;5275.551578115865;5280.049591073605;5287.39194992575;5292.682439053669;5159.5614372778355;5189.325387699612;5193.870153246161;5200.843974680747;5261.210818377236;5281.313429254173;5286.788528458857;5297.284866543045;5298.788048478094;5338.599605029638;5021.69869807809;5025.070361983045;5102.489751024905;5200.869978250574;5201.08980928336;5631.958087753778;5640.32316122068;5646.463585959327;5647.181158731961;5749.453801888814;6189.288231853349;6210.037444196157;6251.468625166866;6272.435480806704;6285.0886621440095;6133.885575987434;6273.404026617464;6285.685715714196;6322.841928951767;6323.304436512026;5753.367129615739;5819.039858423397;5832.62087964281;5851.4148585141575;5919.881602368015;6265.71804268809;6267.467265282502;6269.780557680459;6269.811905642747;6285.717142728588;6075.119107729354;6109.556495504338;6191.938080619136;6227.190465239581;6240.344763799826;6264.655443950626;6305.432511074026;6309.179806625201;6319.33646967071;6325.051242313598;6262.12330273762;6262.780802671885;6262.780802671885;6268.373162683786;6291.307956124822;6096.405739310739;6156.168917196211;6175.96912015437;6223.439890409885;6261.342559031236;4686.835960741358;4704.388429504143;4713.198756211452;4714.339992401066;4754.0016596515115;4171.728837625545;4200.3699445082875;4204.5375008749015;4239.660827133884;4242.8727138185905;5288.867778305573;5289.709066001406;5320.361556613231;5365.892682146336;5562.888742225133;6169.8457538561;6175.660338681326;6219.346968568326;6256.99888017915;6259.061140828912;5675.858103547444;5706.572007099484;5722.971385143048;5743.310802703619;5759.366469688331;5416.647917885325;5427;5428.240046393508;5429.239906413105;5432.674039557639;5443.237946687467;6130.245269656939;6282.748690052346;6349.111124442582;6367.42693157618;6247.5939063960695;6268.0284555892085;6288.654124023223;6307.274663413767;6321.778737744157;6370.108184854217;6377.394147555975;6381.7128229228865;6389.424951754364;6400.935990640034;6050.152978582913;6135.753292002456;6168.845778855564;6182.69086545662;6241.469475094486;6256.967600346074;6268.1851359323;6284.748610055546;6288.402601752826;6292.244930608356;5128.846009647799;6129.448349648553;6209.068639704081;6212.689365531795;6222.751089956351;6038.63768173911;6103.176071230505;6118.7714669719035;6135.478484328882;6196.783112591038;6048.758049677964;6050.0924861269405;6071.932719645293;6104.816855494342;6121.479674227562;6185;6194;6195.504359651127;6200.3489633589625;6209.441150296495;5804.796832110856;5923.851903702442;6005.939940600713;6057.1519987200945;6063.151158837854 01:03:21 INFO - PROCESS | 1949 | |1;ext.html;490.61731849157655;507.8984203159369;529.9788008479663;532.9840104796857;548.3995025447136;29959;31042.379152416965;41325.173496530086;42080.737577872635;42286.577134228646;39889.40165897514;43397;43460;43510.782446087804;43512.78243608785;9506.904930950706;9687.660931867385;9690;9690.515474226295;9712.562934667922;8726.912730872673;8935.865962010575;11925.22486038409;12249.755004899896;12262.202956807823;12198.39008049594;12241.449134788956;12262.69343266421;12280.263184208932;12284.938575307156;8778.341624378134;12170.695732606668;12237.632871013884;12246.0815438842;12248.142630015902;8803.603837827313;9000.819983600291;9003.594838232295;9669.516524173763;11992.220505667105;41133.38299925504;41497.37753933663;41503.7924810374;41633.58366416327;41633.583664163576;3372.8482218300237;3386.9491957620658;3495.1262184453885;3602.35157671619;3681.7790932543867;30477;31733.598409542745;32644.6735532644;32730;32737.017889463354;3291.8024918504966;3376.1897144685345;3435.158386195373;3446.87935922244;3448.137965508623;499000;506187;508310;508521;508996;56568.02011929563;61928.38071619316;62575.37424625696;62582.061269081;62583;61135.694321528106;65481.672591636736;65517.67241163859;65640.34359656437;65812.67093664597;15178.31697573612;16723.91638041802;16998.98006119637;17029.23368448423;17040.31838726462;11738.76522469563;12014.399280035963;12020.699482512833;12671.303078330597;12989.610311690665;16179.514614561347;18864.15111319994;19194.520136996685;19203.32788352401;19228.71156932647;5018.146915024455;7885.211478852184;7902.3678105751405;8036.236557527026;8046.316063134582;898.7842917699705;991.2268430624125;1001.5493028137367;1033.390299723167;1059.613241166984;28777;30634.234144146576;30818.075457736304;31031.844840776103;31193.532097018564;1073.5115522437272;1089.967300980972;1107.8670559532907;1148.322489731046;1261.1991385470292;15075.321610527553;15858.52424427269;15991.840081599268;16049.759253611206;16321.265543050591;633088;646593;651713;652272.0795940228;652430;57273.99999999916;60200;60775.69612151911;60816;60984.69507652522;1231.6982339326564;1279.2196759976407;1370.7738223193262;1406.908550944206;1441.8630230128122;30653;30706.078817635505;30818.383632327677;31465;32214.35571288608;46157;46484.837879053295;46544.53455465402;46669.53330466652;46776.532234677215;471918;472356;472916;473366;474664;21809.469634886067;24076.75923240745;24108;24956.253062285465;24961;38636.420453693776;45151.54848451474;45299;46447.83880402882;46781.766091169324;39329.803350983064;39822.2035559293;40089.59910400975;40900.1819963605;40935.38596921108;39617.60382396254;39813;39878.00609969548;40910.38634420546;41007;37579.436308455945;38244.426333605574;38613.80693096516;38785.80607096946;38974.02564935899;32212;34584.82707586446;35272;35382;35539.644603553636;21752.341228066027;25335;25647.87176064108;25985.480290394466;26127.477450451264 01:03:21 INFO - PROCESS | 1949 | |2;jquery.html;333.89813615070267;346.74514232039456;357.7442128877855;367.5956447907302;386.6346302743908;15919.681606367865;18625.161867715953;21404.785952140475;22100.336989890307;22117.557648847054;20715.37853864383;21237.893810530924;21274.680879786814;21457.785422145775;22437;5362.383325917511;5826.563007774424;6078.787242446515;6100.908486372708;6109.725062372182;5051.898962020758;5996.310424301196;6088.1476593276975;6108;6116.08258761185;6053.606515576495;6055.27336719592;7466.066741657293;7859.68561257549;7871.173526779691;7579.431542634325;7844.882326765103;7889.605519723991;7933.008373953256;7942.801429964268;7602.163761986177;7612.733554325572;7621.314081732615;7626.9618651906385;7628.771136865903;28680.426391472054;29992.55011174834;30183.396332073236;30208.09375718732;30708.53937190944;2307.204014614955;2326;2466.2354670052164;2980;3476.947845782315;12575.874241257654;16932.492025239262;17243.568910777332;17905;17933.316009354934;1917.5685470768965;1982.4250967219489;2003.5492014296813;2027.2600500817243;2043.5095577061547;134413.32793336068;134913;140694;142258;142858.42849429068;18992.542535537985;19683.507912302022;21770.23804166878;21811.781882180974;21960.670589941165;35881;35926.82036589853;35949.56201751953;35982.640173598455;36037;9956.402615842928;10826.133909287239;10857.34855908648;11093.778124437466;11105.222634415513;9058.139476749699;9069.31980101495;9076.364654474124;9204.585793639302;9212;9478.099580539838;9605.567749451291;9809.362391444532;9820.263480239011;9822.65620703272;2947.277916910328;3178.49144136937;3625.546806649169;3732.925341493155;3742.4573436851506;871.1375738019316;938.648006997376;967.3567077893122;1005.9295849290479;1017.4759998600726;21304.680429793567;21995.560088798135;22038.669419958715;22073.779262207492;22097.337079887628;831.4263158420671;937.5827756648226;945.7257395355407;945.9452710228184;956.4309236004566;11094.778104437866;11429.199956003165;11536.884631153749;11539.307641541534;11560.24858384219;579864;586544;593757.0312148412;594167;601232;129433.35283323523;130501.34749326193;130794;131388.3722325548;133753.3312333432;966.8066386722684;980.8528720691811;982.0572250639466;1002.4035698759227;1003.7992401519725;18591.256349745858;18893.90553047226;19077.236910523425;19204;19226.230950761812;40761;51716.15561144173;52682;53519.732401337744;53910.730446347516;76429;78189;79583;80511.59744201241;82422.76365854636;5763.711814409179;7401.592912389655;7404;7431.739889104072;7722.691092356243;9353.906460935576;12626.431810568363;13088.73822523525;13347.599572012856;13380;10791.306287328442;11117.555297788322;11511.712207194552;11534.653960381202;11595.652130436101;11208.439578020903;11312.095032397225;11387.487563059516;11501.712457188638;11573.421328933351;11675.182737208313;11709.473073711533;11747.765044699228;11765.647030589096;11768.764624707286;8145.51126932386;8218.383621228311;8335.749927502186;8396.866423032812;8427.325813934747;11407.973282404624;11478.655640330804;11499.73502914662;11547.364894930859;11554.191206615456 01:03:21 INFO - PROCESS | 1949 | |3;mootools.html;1520.4602366160009;1560.3368568358444;1733.835285647863;1869.4391682495248;1887.5186827359014;8236.382271329652;8569.871451928226;8743;8748.69379571715;8760.912390876088;7719.189485104067;7949.92050079499;8307.91692083079;8505.979282486094;8548.273396761268;2335.976640233597;2365.1721897335965;2367.7277113131954;2371.205646108556;2372.193454225563;1928.4985903665079;2281.851679640826;2310.745817960023;2311.179531266401;2332.568474832153;2080.9063592138314;2146.796054374832;2292.6675632033343;2351.5061837014164;2356.4108972756812;1979.208316673342;2340.707411573553;2354.5761762882676;2372.6203807390907;2374.192774456693;2338.976610233893;2347.7065366829147;2353.5292941411617;2356.175338631482;2358;8733.03936566977;8814.030456649827;8844.292456603456;8868.02451730309;8885.4668719877;5110.437851836295;5244.737763111867;5303.496167864047;5306.151015837448;5311.044012077825;3537.0273174876857;3562.0382496725997;3573.160307327776;3612.277544491112;3619.1856832212807;1052.4948024947992;1054.599252284127;1060.459165825427;1066.9466526673634;1075.569772091162;11500.25248358854;11524.59663911759;11528.020118289955;11543.422828858524;11545.307281563133;3951.249262640089;4446.9555304447185;4480.32795080734;4689.085628302449;4695.694779839299;8350.415470916978;9764.414135151914;9778.853317200248;9788.168005719594;9792.902070979342;5265.236540701653;5265.710385928811;5274.92087618686;5278.947210527922;5301.231321458367;4746.43042834862;4826.0347930414055;4831.444383895897;4836.371271734652;4836.95163048365;3366.2762506061313;3824.8661296855034;3871.341871881787;3936.9960660031506;4048.4332193492346;1168.8013037783596;1216.087934049463;1263.860975292717;1266.265565971734;1281.2120545864414;780.9180036096128;889.8175873945826;895.2971917045088;937.5593471068587;938.5448057692014;5791.739371728282;5926.407359264125;5960.910586341209;6011.849703757353;6136.8772624547255;801.8757092650649;815.8048459007582;906.909309069101;947.1854205383365;995.9402435853872;3676.00747798093;3822.4075268333454;3926.5484469285825;3990.640842324147;4056.6551843093666;8841.778955526035;8910.732678019669;10231.13035391985;10646.988536089058;10684.51919663617;10479.371237725762;10623.628173013907;10630.893691062991;10648.574057037631;10666.626668066581;7927.286544211049;8087.5551844647935;8145.981752280964;8147.918520814953;8174;5762.193292939076;5802.912956305743;5841.415858414124;5898.705064746831;5952.940470595238;9803.558839852081;9808.754781130528;9829.606815727291;9881.851772223567;9896.15882649954;9610.327277090537;9971.102600765966;9991.300608957303;10143.54354054084;10143.64497242593;6370.968145159244;7421.628918554159;7507.88738168917;7508.849823003618;7520.8871866920945;6683.465322774069;8067.556284404414;8179.67281308741;8219.589020549069;8304.335653147613;7375.963120184365;7399.112106547249;7416.7774966751085;7546.811329716801;7563.584002879675;7175.138983322035;7279.053723015974;7283.672234749343;7413.481056326005;7416.6291685414435;6946.722131114699;6992.265812089658;7005.649717514002;7014.894776578253;7016.228214896255;4887.975560122177;4999.875003124951;5019.64862459639;5068.974655126701;5098.617603679665;5043.092243396224;5054.620903432331;5099.23511473282;5102.948970510396;5171.50870667286 01:03:21 INFO - PROCESS | 1949 | |4;prototype.html;273.79738993145077;299.98350090745;303.0967716205707;309.7986308899216;315.8894386964561;4480.171168333861;5392.541633961108;5401.27082843816;5405.945940540593;5409.918851217235;5106.64253502255;5127.846164615058;5183.393148124084;5350.759215835287;5446.972765136179;3376.7298616110775;3397.7281817454545;4136.9864383226;4141.440905477767;4167.166566686675;4136.689748268876;4139.19285739281;4147.7926103694845;4163.854265100722;4178.603032711902;3216.9839150804332;3649.5255616769914;4066.369712694537;4073.388991651246;4124.835006599732;4078.9796051019557;4088.7342322749223;4098.938515922248;4114.300568903293;4119.876403707894;3535.222251104753;3550.7869527828157;3555.8933232003083;3566.946495802565;3568.4825700273573;4983.950160498385;5298.947010529922;5313.521783039545;5393.946060539383;5407.297051383334;4677.695949763254;4704.435467743859;4716.316134160562;4735.171345014609;4750.12122757291;5572.804951826707;5742.966266072105;5756.380846714776;5764.7117644117625;5766.424816613684;3280.7539434542505;3528.7177025837873;3803.8574049283666;3912.921741565181;3915.7846318452757;5219.8434046978655;5934.495567876736;5968.432998865101;5989.55078369124;5994.730237139339;3605.94591081134;3630.2920930418845;3942.1918506706056;3971.5035620547433;3990.7605543667473;3784.262068896594;3874;4030.7984600769846;4034.536028356718;4056.959430405658;4127.195196936628;4180.665546756252;4488.835371063393;4534.6372290216705;4717.882052948635;4788.090262850047;5766.433936898124;5815.941840581625;5877.823665290048;5896.380880007623;1150.8676502202186;1351.6620844788804;1370.1436602123672;1372.8901687865146;1390.2978995607155;767.8809784483414;825.6078362777632;834.4729145663422;859.6604341285157;918.8713580098791;4452.532484089189;5320.467953204648;5352.91970620441;5359.356877174764;5363.919541206885;5773.942260577424;5874.706264686749;5912.586118971717;5922.482944748464;5972.910406343908;4551.40831691878;5239.711815850165;5346.518813306821;5357.866053348697;5371.838844834661;2760.4479104179245;3092.6752690967123;3111.81329120249;3119.53207018949;3131.9530207046914;5218.765155568009;5230.450802665665;5515.669059856341;5946;6056.909146362808;6023.367546407651;6024.698765061729;6043.917602023;6056.878862422727;6081.0270356743595;5420.186971954317;5945.494632956247;6077.878442431127;6111.938880611226;6114.266288045463;5616.831495055155;5822.650640961556;5855;5855.23881895368;5889.440503152194;4742.288656701522;5362;5383.7846486140115;5724.284464441945;5730.169125476699;4846.636502262415;5933.940660593512;6039.667818270037;6047.48596369296;6069.150318955261;3417.9746076177544;3893.377059670439;3913.882583522499;3922.9607703922597;3934.744241624285;5402.864928376822;5632.493075623213;5807.60617451817;5825.766969321349;5866.794662186803;4700.976495117503;5285.036222832875;5703.258576385043;5716.914246286392;5742.339630942328;4672.509386514503;5649.350324712711;5680.573956953162;5684.459976302244;5733.856653583527;4700.485240396371;5342.519173274424;5507.779688812403;5549.278593782782;5654.293213348332;5470;5654.802081927113;5700.800471983461;5742.540596752333;5768.451997060272;5448.591355648263;5600.047991841316;5646.181303711021;5649.406812284651;5732.942670573241 01:03:21 INFO - PROCESS | 1949 | |5;yui.html;707.4658632732288;735.779266220134;739.5267029101376;790.3282210121398;816.6733306677324;15445.22773861308;16339.428120015802;16406.343746250135;16418.097004664753;16420.178991050445;12257.877421225785;14594.124352538855;14798.556043318691;15428.922855385736;15886.205689715496;686.800827759949;713.2047766740073;850.8766228896807;883.2227639677075;887.5384799904047;839.9790005249856;859.7936495241129;860.2043110123111;860.4149178558578;863.5854789700948;717.8456631824157;888.6934007767343;906.6418764587984;910.899801021887;912.7216199059284;879.1647934462254;887.1128871128872;888.4402826219473;890.1543533643065;890.2922176869405;673.2930423055772;673.7439772886321;675.2369822101043;675.530506298123;678.4301187002892;14719.852801471956;14780.334884930204;14867.330970106372;14882.702345953021;15054.322555485029;14250.358733857001;14306;14336.42654293827;14427.639309017253;14442.266927968605;12909;13205.20768753878;13211.339433028406;13304.534341298106;13531.932340338333;4552.772361381918;4816.56650901417;4842.539958703917;4870.512948705136;4876.902461950741;112690.43654781756;112852.87147128506;112945.87054129518;113153.43423282914;113345;9881.456519891475;11272.887271127183;11300.886991129983;11495.195336326376;11509.884901150881;22761.772382276296;22775.658365124535;22796.202132925268;22796.886015569817;22808.315750527177;8008.559529225832;8024.83950321002;8059.113497515269;8079.717209897625;8300.543470109082;4471.642268618502;4545.659075569345;4577.977110114494;4709.222978208557;4723.7401942893475;3423.554937858112;3580.3197392495863;3586.479960405779;3586.8206589670936;3587.3722098633157;644.8258970078052;647.6340867409898;655.9737610495526;658.8748137853793;670.5674839728446;639.8304449320933;659.85153340498;672.586359388982;688.2841844481783;692.2592825676578;9310;9321.766955826159;9628.566714497865;9630.614775408905;9641.758956026155;550.6806052489627;595.3748564007775;632.4655665962255;664.5182242873974;671.8152508060225;4555.544445555418;4580.221362368338;4613.423322084739;4624.583787459145;4634.814607415666;150299.49700503075;155329;156833;158885;159453.20273398558;135801.3209933944;136211.31894340663;136986;138442;141652.58347416393;92496.53751731332;108758.45620771845;114711.42644286725;114853.42573287248;115493.42253288679;8668.869966950375;8696.130386961253;9039.322050846082;9043.095690431168;9220.538973051187;57684.71157644353;59808;64583.70832583416;65162.37094072686;68082.31917680759;88646;91147.54426228092;92112;92560;101922;13440.193588384729;13485.797713034508;13604.86395136036;13656.93171534136;14050.78923816164;15010.099394036393;15251.237438128272;15286.388544458097;15339.463118790789;15769.290381932611;13593.116447430886;13739.158144212975;14205.502807401692;14381.280935952951;14436.061655992327;12708.536567249219;14284.07153535017;14286.071405358618;14332.283385830875;14727.631809204855;13509.324533773075;13847.515336963157;14049.508267210598;14612.707745844811;14801;11209.943950280196;11314.434278286217;11386.886131138583;11442.427878606202;11812.527498899948;9955.900440995498;10782.353058816496;11301.208915375844;11393.373364464702;11680.649580512598 01:03:21 INFO - PROCESS | 1949 | __end_tp_report 01:03:21 INFO - PROCESS | 1949 | __start_cc_report 01:03:21 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1282 01:03:21 INFO - PROCESS | 1949 | __end_cc_report 01:03:21 INFO - PROCESS | 1949 | __startTimestamp1467273801451__endTimestamp 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | ------- Summary: start ------- 01:03:21 INFO - PROCESS | 1949 | Number of tests: 6 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | [#0] dojo.html Cycles:165 Average:5739.49 Median:6050.09 stddev:671.78 (11.1%) stddev-sans-first:647.74 01:03:21 INFO - PROCESS | 1949 | Values: 3375.7 3375.7 3378.3 3391.0 3432.0 5626.3 5652.1 5729.3 5737.5 5759.4 5747.3 5770.7 5772.6 5781.0 5781.6 5177.2 5207.0 5210.0 5229.5 5290.1 5260.9 5275.6 5280.0 5287.4 5292.7 5159.6 5189.3 5193.9 5200.8 5261.2 5281.3 5286.8 5297.3 5298.8 5338.6 5021.7 5025.1 5102.5 5200.9 5201.1 5632.0 5640.3 5646.5 5647.2 5749.5 6189.3 6210.0 6251.5 6272.4 6285.1 6133.9 6273.4 6285.7 6322.8 6323.3 5753.4 5819.0 5832.6 5851.4 5919.9 6265.7 6267.5 6269.8 6269.8 6285.7 6075.1 6109.6 6191.9 6227.2 6240.3 6264.7 6305.4 6309.2 6319.3 6325.1 6262.1 6262.8 6262.8 6268.4 6291.3 6096.4 6156.2 6176.0 6223.4 6261.3 4686.8 4704.4 4713.2 4714.3 4754.0 4171.7 4200.4 4204.5 4239.7 4242.9 5288.9 5289.7 5320.4 5365.9 5562.9 6169.8 6175.7 6219.3 6257.0 6259.1 5675.9 5706.6 5723.0 5743.3 5759.4 5416.6 5427.0 5428.2 5429.2 5432.7 5443.2 6130.2 6282.7 6349.1 6367.4 6247.6 6268.0 6288.7 6307.3 6321.8 6370.1 6377.4 6381.7 6389.4 6400.9 6050.2 6135.8 6168.8 6182.7 6241.5 6257.0 6268.2 6284.7 6288.4 6292.2 5128.8 6129.4 6209.1 6212.7 6222.8 6038.6 6103.2 6118.8 6135.5 6196.8 6048.8 6050.1 6071.9 6104.8 6121.5 6185.0 6194.0 6195.5 6200.3 6209.4 5804.8 5923.9 6005.9 6057.2 6063.2 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | [#1] ext.html Cycles:180 Average:68241.75 Median:38625.11 stddev:146061.14 (378.2%) stddev-sans-first:146382.30 01:03:21 INFO - PROCESS | 1949 | Values: 490.6 507.9 530.0 533.0 548.4 29959.0 31042.4 41325.2 42080.7 42286.6 39889.4 43397.0 43460.0 43510.8 43512.8 9506.9 9687.7 9690.0 9690.5 9712.6 8726.9 8935.9 11925.2 12249.8 12262.2 12198.4 12241.4 12262.7 12280.3 12284.9 8778.3 12170.7 12237.6 12246.1 12248.1 8803.6 9000.8 9003.6 9669.5 11992.2 41133.4 41497.4 41503.8 41633.6 41633.6 3372.8 3386.9 3495.1 3602.4 3681.8 30477.0 31733.6 32644.7 32730.0 32737.0 3291.8 3376.2 3435.2 3446.9 3448.1 499000.0 506187.0 508310.0 508521.0 508996.0 56568.0 61928.4 62575.4 62582.1 62583.0 61135.7 65481.7 65517.7 65640.3 65812.7 15178.3 16723.9 16999.0 17029.2 17040.3 11738.8 12014.4 12020.7 12671.3 12989.6 16179.5 18864.2 19194.5 19203.3 19228.7 5018.1 7885.2 7902.4 8036.2 8046.3 898.8 991.2 1001.5 1033.4 1059.6 28777.0 30634.2 30818.1 31031.8 31193.5 1073.5 1090.0 1107.9 1148.3 1261.2 15075.3 15858.5 15991.8 16049.8 16321.3 633088.0 646593.0 651713.0 652272.1 652430.0 57274.0 60200.0 60775.7 60816.0 60984.7 1231.7 1279.2 1370.8 1406.9 1441.9 30653.0 30706.1 30818.4 31465.0 32214.4 46157.0 46484.8 46544.5 46669.5 46776.5 471918.0 472356.0 472916.0 473366.0 474664.0 21809.5 24076.8 24108.0 24956.3 24961.0 38636.4 45151.5 45299.0 46447.8 46781.8 39329.8 39822.2 40089.6 40900.2 40935.4 39617.6 39813.0 39878.0 40910.4 41007.0 37579.4 38244.4 38613.8 38785.8 38974.0 32212.0 34584.8 35272.0 35382.0 35539.6 21752.3 25335.0 25647.9 25985.5 26127.5 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | [#2] jquery.html Cycles:180 Average:37148.15 Median:30458.32 stddev:99064.38 (325.2%) stddev-sans-first:99303.72 01:03:21 INFO - PROCESS | 1949 | Values: 333.9 346.7 357.7 367.6 386.6 15919.7 18625.2 21404.8 22100.3 22117.6 20715.4 21237.9 21274.7 21457.8 22437.0 5362.4 5826.6 6078.8 6100.9 6109.7 5051.9 5996.3 6088.1 6108.0 6116.1 6053.6 6055.3 7466.1 7859.7 7871.2 7579.4 7844.9 7889.6 7933.0 7942.8 7602.2 7612.7 7621.3 7627.0 7628.8 28680.4 29992.6 30183.4 30208.1 30708.5 2307.2 2326.0 2466.2 2980.0 3476.9 12575.9 16932.5 17243.6 17905.0 17933.3 1917.6 1982.4 2003.5 2027.3 2043.5 134413.3 134913.0 140694.0 142258.0 142858.4 18992.5 19683.5 21770.2 21811.8 21960.7 35881.0 35926.8 35949.6 35982.6 36037.0 9956.4 10826.1 10857.3 11093.8 11105.2 9058.1 9069.3 9076.4 9204.6 9212.0 9478.1 9605.6 9809.4 9820.3 9822.7 2947.3 3178.5 3625.5 3732.9 3742.5 871.1 938.6 967.4 1005.9 1017.5 21304.7 21995.6 22038.7 22073.8 22097.3 831.4 937.6 945.7 945.9 956.4 11094.8 11429.2 11536.9 11539.3 11560.2 579864.0 586544.0 593757.0 594167.0 601232.0 129433.4 130501.3 130794.0 131388.4 133753.3 966.8 980.9 982.1 1002.4 1003.8 18591.3 18893.9 19077.2 19204.0 19226.2 40761.0 51716.2 52682.0 53519.7 53910.7 76429.0 78189.0 79583.0 80511.6 82422.8 5763.7 7401.6 7404.0 7431.7 7722.7 9353.9 12626.4 13088.7 13347.6 13380.0 10791.3 11117.6 11511.7 11534.7 11595.7 11208.4 11312.1 11387.5 11501.7 11573.4 11675.2 11709.5 11747.8 11765.6 11768.8 8145.5 8218.4 8335.7 8396.9 8427.3 11408.0 11478.7 11499.7 11547.4 11554.2 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | [#3] mootools.html Cycles:180 Average:5618.54 Median:5208.12 stddev:3119.92 (59.9%) stddev-sans-first:3113.47 01:03:21 INFO - PROCESS | 1949 | Values: 1520.5 1560.3 1733.8 1869.4 1887.5 8236.4 8569.9 8743.0 8748.7 8760.9 7719.2 7949.9 8307.9 8506.0 8548.3 2336.0 2365.2 2367.7 2371.2 2372.2 1928.5 2281.9 2310.7 2311.2 2332.6 2080.9 2146.8 2292.7 2351.5 2356.4 1979.2 2340.7 2354.6 2372.6 2374.2 2339.0 2347.7 2353.5 2356.2 2358.0 8733.0 8814.0 8844.3 8868.0 8885.5 5110.4 5244.7 5303.5 5306.2 5311.0 3537.0 3562.0 3573.2 3612.3 3619.2 1052.5 1054.6 1060.5 1066.9 1075.6 11500.3 11524.6 11528.0 11543.4 11545.3 3951.2 4447.0 4480.3 4689.1 4695.7 8350.4 9764.4 9778.9 9788.2 9792.9 5265.2 5265.7 5274.9 5278.9 5301.2 4746.4 4826.0 4831.4 4836.4 4837.0 3366.3 3824.9 3871.3 3937.0 4048.4 1168.8 1216.1 1263.9 1266.3 1281.2 780.9 889.8 895.3 937.6 938.5 5791.7 5926.4 5960.9 6011.8 6136.9 801.9 815.8 906.9 947.2 995.9 3676.0 3822.4 3926.5 3990.6 4056.7 8841.8 8910.7 10231.1 10647.0 10684.5 10479.4 10623.6 10630.9 10648.6 10666.6 7927.3 8087.6 8146.0 8147.9 8174.0 5762.2 5802.9 5841.4 5898.7 5952.9 9803.6 9808.8 9829.6 9881.9 9896.2 9610.3 9971.1 9991.3 10143.5 10143.6 6371.0 7421.6 7507.9 7508.8 7520.9 6683.5 8067.6 8179.7 8219.6 8304.3 7376.0 7399.1 7416.8 7546.8 7563.6 7175.1 7279.1 7283.7 7413.5 7416.6 6946.7 6992.3 7005.6 7014.9 7016.2 4888.0 4999.9 5019.6 5069.0 5098.6 5043.1 5054.6 5099.2 5102.9 5171.5 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | [#4] prototype.html Cycles:180 Average:4621.26 Median:5331.49 stddev:1440.92 (27.0%) stddev-sans-first:1407.53 01:03:21 INFO - PROCESS | 1949 | Values: 273.8 300.0 303.1 309.8 315.9 4480.2 5392.5 5401.3 5405.9 5409.9 5106.6 5127.8 5183.4 5350.8 5447.0 3376.7 3397.7 4137.0 4141.4 4167.2 4136.7 4139.2 4147.8 4163.9 4178.6 3217.0 3649.5 4066.4 4073.4 4124.8 4079.0 4088.7 4098.9 4114.3 4119.9 3535.2 3550.8 3555.9 3566.9 3568.5 4984.0 5298.9 5313.5 5393.9 5407.3 4677.7 4704.4 4716.3 4735.2 4750.1 5572.8 5743.0 5756.4 5764.7 5766.4 3280.8 3528.7 3803.9 3912.9 3915.8 5219.8 5934.5 5968.4 5989.6 5994.7 3605.9 3630.3 3942.2 3971.5 3990.8 3784.3 3874.0 4030.8 4034.5 4057.0 4127.2 4180.7 4488.8 4534.6 4717.9 4788.1 5766.4 5815.9 5877.8 5896.4 1150.9 1351.7 1370.1 1372.9 1390.3 767.9 825.6 834.5 859.7 918.9 4452.5 5320.5 5352.9 5359.4 5363.9 5773.9 5874.7 5912.6 5922.5 5972.9 4551.4 5239.7 5346.5 5357.9 5371.8 2760.4 3092.7 3111.8 3119.5 3132.0 5218.8 5230.5 5515.7 5946.0 6056.9 6023.4 6024.7 6043.9 6056.9 6081.0 5420.2 5945.5 6077.9 6111.9 6114.3 5616.8 5822.7 5855.0 5855.2 5889.4 4742.3 5362.0 5383.8 5724.3 5730.2 4846.6 5933.9 6039.7 6047.5 6069.2 3418.0 3893.4 3913.9 3923.0 3934.7 5402.9 5632.5 5807.6 5825.8 5866.8 4701.0 5285.0 5703.3 5716.9 5742.3 4672.5 5649.4 5680.6 5684.5 5733.9 4700.5 5342.5 5507.8 5549.3 5654.3 5470.0 5654.8 5700.8 5742.5 5768.5 5448.6 5600.0 5646.2 5649.4 5732.9 01:03:21 INFO - PROCESS | 1949 | 01:03:21 INFO - PROCESS | 1949 | [#5] yui.html Cycles:180 Average:25675.76 Median:3586.65 stddev:41098.87 (1145.9%) stddev-sans-first:41171.40 01:03:21 INFO - PROCESS | 1949 | Values: 707.5 735.8 739.5 790.3 816.7 15445.2 16339.4 16406.3 16418.1 16420.2 12257.9 14594.1 14798.6 15428.9 15886.2 686.8 713.2 850.9 883.2 887.5 840.0 859.8 860.2 860.4 863.6 717.8 888.7 906.6 910.9 912.7 879.2 887.1 888.4 890.2 890.3 673.3 673.7 675.2 675.5 678.4 14719.9 14780.3 14867.3 14882.7 15054.3 14250.4 14306.0 14336.4 14427.6 14442.3 12909.0 13205.2 13211.3 13304.5 13531.9 4552.8 4816.6 4842.5 4870.5 4876.9 112690.4 112852.9 112945.9 113153.4 113345.0 9881.5 11272.9 11300.9 11495.2 11509.9 22761.8 22775.7 22796.2 22796.9 22808.3 8008.6 8024.8 8059.1 8079.7 8300.5 4471.6 4545.7 4578.0 4709.2 4723.7 3423.6 3580.3 3586.5 3586.8 3587.4 644.8 647.6 656.0 658.9 670.6 639.8 659.9 672.6 688.3 692.3 9310.0 9321.8 9628.6 9630.6 9641.8 550.7 595.4 632.5 664.5 671.8 4555.5 4580.2 4613.4 4624.6 4634.8 150299.5 155329.0 156833.0 158885.0 159453.2 135801.3 136211.3 136986.0 138442.0 141652.6 92496.5 108758.5 114711.4 114853.4 115493.4 8668.9 8696.1 9039.3 9043.1 9220.5 57684.7 59808.0 64583.7 65162.4 68082.3 88646.0 91147.5 92112.0 92560.0 101922.0 13440.2 13485.8 13604.9 13656.9 14050.8 15010.1 15251.2 15286.4 15339.5 15769.3 13593.1 13739.2 14205.5 14381.3 14436.1 12708.5 14284.1 14286.1 14332.3 14727.6 13509.3 13847.5 14049.5 14612.7 14801.0 11209.9 11314.4 11386.9 11442.4 11812.5 9955.9 10782.4 11301.2 11393.4 11680.6 01:03:21 INFO - PROCESS | 1949 | -------- Summary: end -------- 01:03:21 INFO - PROCESS | 1949 | 01:03:22 INFO - TEST-INFO | 1949: exit 0 01:03:22 INFO - TEST-OK | dromaeo_css | took 1115914ms 01:03:22 INFO - TEST-START | kraken 01:03:22 INFO - operating with platform_type : mac_ 01:03:22 INFO - Initialising browser for kraken test... 01:03:22 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpOOVoL8/profile http://localhost:52302/getInfo.html) 01:03:24 INFO - PROCESS | 1952 | __metrics Screen width/height:1600/1200 01:03:24 INFO - PROCESS | 1952 | colorDepth:24 01:03:24 INFO - PROCESS | 1952 | Browser inner width/height: 1024/689 01:03:24 INFO - PROCESS | 1952 | __metrics 01:03:24 INFO - PROCESS | 1952 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:03:24 INFO - PROCESS | 1952 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:03:24 INFO - TEST-INFO | 1952: exit 0 01:03:24 INFO - Browser initialized. 01:03:24 INFO - Running cycle 1/1 for kraken test... 01:03:24 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpOOVoL8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:03:36 INFO - PROCESS | 1953 | RSS: Main: 243924992 01:03:36 INFO - PROCESS | 1953 | 01:03:39 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52302/tests/kraken/driver.html?testName=audio-beat-detection) 01:03:40 INFO - PROCESS | 1953 | RSS: Main: 294727680 01:03:40 INFO - PROCESS | 1953 | 01:03:43 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52302/tests/kraken/driver.html?testName=audio-dft) 01:03:43 INFO - PROCESS | 1953 | RSS: Main: 304885760 01:03:43 INFO - PROCESS | 1953 | 01:03:47 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52302/tests/kraken/driver.html?testName=audio-fft) 01:03:47 INFO - PROCESS | 1953 | RSS: Main: 390881280 01:03:47 INFO - PROCESS | 1953 | 01:03:49 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52302/tests/kraken/driver.html?testName=audio-oscillator) 01:03:50 INFO - PROCESS | 1953 | RSS: Main: 291799040 01:03:50 INFO - PROCESS | 1953 | 01:03:52 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:03:53 INFO - PROCESS | 1953 | RSS: Main: 295677952 01:03:53 INFO - PROCESS | 1953 | 01:03:55 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52302/tests/kraken/driver.html?testName=imaging-darkroom) 01:03:56 INFO - PROCESS | 1953 | RSS: Main: 331923456 01:03:56 INFO - PROCESS | 1953 | 01:03:59 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52302/tests/kraken/driver.html?testName=imaging-desaturate) 01:04:00 INFO - PROCESS | 1953 | RSS: Main: 335527936 01:04:00 INFO - PROCESS | 1953 | 01:04:02 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52302/tests/kraken/driver.html?testName=json-parse-financial) 01:04:03 INFO - PROCESS | 1953 | RSS: Main: 333451264 01:04:03 INFO - PROCESS | 1953 | 01:04:04 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:04:05 INFO - PROCESS | 1953 | RSS: Main: 312344576 01:04:05 INFO - PROCESS | 1953 | 01:04:07 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:04:08 INFO - PROCESS | 1953 | RSS: Main: 319688704 01:04:08 INFO - PROCESS | 1953 | 01:04:10 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:04:10 INFO - PROCESS | 1953 | RSS: Main: 322654208 01:04:10 INFO - PROCESS | 1953 | 01:04:13 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:04:14 INFO - PROCESS | 1953 | RSS: Main: 324952064 01:04:14 INFO - PROCESS | 1953 | 01:04:17 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:04:17 INFO - PROCESS | 1953 | RSS: Main: 324096000 01:04:17 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52302/tests/kraken/driver.html?testName=ai-astar) 01:04:19 INFO - PROCESS | 1953 | RSS: Main: 367808512 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | __start_tp_report 01:04:19 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 01:04:19 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 01:04:19 INFO - PROCESS | 1953 | |i|pagename|runs| 01:04:19 INFO - PROCESS | 1953 | |0;ai-astar;99;112;113;112;115;112;113;113;112;114 01:04:19 INFO - PROCESS | 1953 | |1;audio-beat-detection;142;111;106;159;135;136;133;108;159;108 01:04:19 INFO - PROCESS | 1953 | |2;audio-dft;185;185;182;182;184;182;258;194;183;184 01:04:19 INFO - PROCESS | 1953 | |3;audio-fft;77;75;57;107;57;56;61;59;98;57 01:04:19 INFO - PROCESS | 1953 | |4;audio-oscillator;84;89;94;70;74;69;92;68;68;97 01:04:19 INFO - PROCESS | 1953 | |5;imaging-gaussian-blur;87;101;118;84;87;84;90;86;88;84 01:04:19 INFO - PROCESS | 1953 | |6;imaging-darkroom;93;93;94;94;92;93;94;94;123;150 01:04:19 INFO - PROCESS | 1953 | |7;imaging-desaturate;86;84;86;89;87;86;85;85;83;84 01:04:19 INFO - PROCESS | 1953 | |8;json-parse-financial;55;55;56;56;54;55;56;55;52;54 01:04:19 INFO - PROCESS | 1953 | |9;json-stringify-tinderbox;65;66;80;76;70;71;68;71;69;72 01:04:19 INFO - PROCESS | 1953 | |10;stanford-crypto-aes;84;84;84;84;84;81;85;86;88;100 01:04:19 INFO - PROCESS | 1953 | |11;stanford-crypto-ccm;144;155;137;144;125;142;142;152;125;128 01:04:19 INFO - PROCESS | 1953 | |12;stanford-crypto-pbkdf2;162;163;162;163;163;162;156;161;161;161 01:04:19 INFO - PROCESS | 1953 | |13;stanford-crypto-sha256-iterative;66;68;79;87;87;85;72;64;65;66 01:04:19 INFO - PROCESS | 1953 | __end_tp_report 01:04:19 INFO - PROCESS | 1953 | __start_cc_report 01:04:19 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,1991 01:04:19 INFO - PROCESS | 1953 | __end_cc_report 01:04:19 INFO - PROCESS | 1953 | __startTimestamp1467273859980__endTimestamp 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | ------- Summary: start ------- 01:04:19 INFO - PROCESS | 1953 | Number of tests: 14 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:4.50 (4.0%) stddev-sans-first:1.05 01:04:19 INFO - PROCESS | 1953 | Values: 99.0 112.0 113.0 112.0 115.0 112.0 113.0 113.0 112.0 114.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:135.50 stddev:20.55 (15.2%) stddev-sans-first:21.31 01:04:19 INFO - PROCESS | 1953 | Values: 142.0 111.0 106.0 159.0 135.0 136.0 133.0 108.0 159.0 108.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#2] audio-dft Cycles:10 Average:191.90 Median:184.50 stddev:23.49 (12.7%) stddev-sans-first:24.78 01:04:19 INFO - PROCESS | 1953 | Values: 185.0 185.0 182.0 182.0 184.0 182.0 258.0 194.0 183.0 184.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#3] audio-fft Cycles:10 Average:70.40 Median:60.00 stddev:18.65 (31.1%) stddev-sans-first:19.63 01:04:19 INFO - PROCESS | 1953 | Values: 77.0 75.0 57.0 107.0 57.0 56.0 61.0 59.0 98.0 57.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:86.50 stddev:11.87 (13.7%) stddev-sans-first:12.52 01:04:19 INFO - PROCESS | 1953 | Values: 84.0 89.0 94.0 70.0 74.0 69.0 92.0 68.0 68.0 97.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:86.50 stddev:10.76 (12.4%) stddev-sans-first:11.32 01:04:19 INFO - PROCESS | 1953 | Values: 87.0 101.0 118.0 84.0 87.0 84.0 90.0 86.0 88.0 84.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:93.50 stddev:19.28 (20.6%) stddev-sans-first:20.17 01:04:19 INFO - PROCESS | 1953 | Values: 93.0 93.0 94.0 94.0 92.0 93.0 94.0 94.0 123.0 150.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.72 (2.0%) stddev-sans-first:1.81 01:04:19 INFO - PROCESS | 1953 | Values: 86.0 84.0 86.0 89.0 87.0 86.0 85.0 85.0 83.0 84.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.23 (2.2%) stddev-sans-first:1.30 01:04:19 INFO - PROCESS | 1953 | Values: 55.0 55.0 56.0 56.0 54.0 55.0 56.0 55.0 52.0 54.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:4.49 (6.3%) stddev-sans-first:4.25 01:04:19 INFO - PROCESS | 1953 | Values: 65.0 66.0 80.0 76.0 70.0 71.0 68.0 71.0 69.0 72.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:5.23 (6.2%) stddev-sans-first:5.49 01:04:19 INFO - PROCESS | 1953 | Values: 84.0 84.0 84.0 84.0 84.0 81.0 85.0 86.0 88.0 100.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:143.00 stddev:10.59 (7.4%) stddev-sans-first:11.10 01:04:19 INFO - PROCESS | 1953 | Values: 144.0 155.0 137.0 144.0 125.0 142.0 142.0 152.0 125.0 128.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:2.07 (1.3%) stddev-sans-first:2.18 01:04:19 INFO - PROCESS | 1953 | Values: 162.0 163.0 162.0 163.0 163.0 162.0 156.0 161.0 161.0 161.0 01:04:19 INFO - PROCESS | 1953 | 01:04:19 INFO - PROCESS | 1953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:75.50 stddev:9.62 (12.7%) stddev-sans-first:9.77 01:04:19 INFO - PROCESS | 1953 | Values: 66.0 68.0 79.0 87.0 87.0 85.0 72.0 64.0 65.0 66.0 01:04:19 INFO - PROCESS | 1953 | -------- Summary: end -------- 01:04:19 INFO - PROCESS | 1953 | 01:04:20 INFO - TEST-INFO | 1953: exit 0 01:04:20 INFO - TEST-OK | kraken | took 58744ms 01:04:20 INFO - SUITE-END | took 1174s 01:04:21 INFO - Completed test suite (00:19:35) 01:04:21 INFO - javascript benchmark 01:04:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.6961873431387, 3375.7130643895266, 3378.30744697337, 3390.9830450847735, 3432.0, 5626.324841019084, 5652.09566469365, 5729.312482502095, 5737.454941780529, 5759.366469688336, 5747.281589801275, 5770.740316685748, 5772.5670574706955, 5781.017227071397, 5781.595288329819, 5177.171652535595, 5206.973965130169, 5210.0, 5229.50319719626, 5290.100682883919, 5260.868478288055, 5275.551578115865, 5280.049591073605, 5287.39194992575, 5292.682439053669, 5159.5614372778355, 5189.325387699612, 5193.870153246161, 5200.843974680747, 5261.210818377236, 5281.313429254173, 5286.788528458857, 5297.284866543045, 5298.788048478094, 5338.599605029638, 5021.69869807809, 5025.070361983045, 5102.489751024905, 5200.869978250574, 5201.08980928336, 5631.958087753778, 5640.32316122068, 5646.463585959327, 5647.181158731961, 5749.453801888814, 6189.288231853349, 6210.037444196157, 6251.468625166866, 6272.435480806704, 6285.0886621440095, 6133.885575987434, 6273.404026617464, 6285.685715714196, 6322.841928951767, 6323.304436512026, 5753.367129615739, 5819.039858423397, 5832.62087964281, 5851.4148585141575, 5919.881602368015, 6265.71804268809, 6267.467265282502, 6269.780557680459, 6269.811905642747, 6285.717142728588, 6075.119107729354, 6109.556495504338, 6191.938080619136, 6227.190465239581, 6240.344763799826, 6264.655443950626, 6305.432511074026, 6309.179806625201, 6319.33646967071, 6325.051242313598, 6262.12330273762, 6262.780802671885, 6262.780802671885, 6268.373162683786, 6291.307956124822, 6096.405739310739, 6156.168917196211, 6175.96912015437, 6223.439890409885, 6261.342559031236, 4686.835960741358, 4704.388429504143, 4713.198756211452, 4714.339992401066, 4754.0016596515115, 4171.728837625545, 4200.3699445082875, 4204.5375008749015, 4239.660827133884, 4242.8727138185905, 5288.867778305573, 5289.709066001406, 5320.361556613231, 5365.892682146336, 5562.888742225133, 6169.8457538561, 6175.660338681326, 6219.346968568326, 6256.99888017915, 6259.061140828912, 5675.858103547444, 5706.572007099484, 5722.971385143048, 5743.310802703619, 5759.366469688331, 5416.647917885325, 5427.0, 5428.240046393508, 5429.239906413105, 5432.674039557639, 5443.237946687467, 6130.245269656939, 6282.748690052346, 6349.111124442582, 6367.42693157618, 6247.5939063960695, 6268.0284555892085, 6288.654124023223, 6307.274663413767, 6321.778737744157, 6370.108184854217, 6377.394147555975, 6381.7128229228865, 6389.424951754364, 6400.935990640034, 6050.152978582913, 6135.753292002456, 6168.845778855564, 6182.69086545662, 6241.469475094486, 6256.967600346074, 6268.1851359323, 6284.748610055546, 6288.402601752826, 6292.244930608356, 5128.846009647799, 6129.448349648553, 6209.068639704081, 6212.689365531795, 6222.751089956351, 6038.63768173911, 6103.176071230505, 6118.7714669719035, 6135.478484328882, 6196.783112591038, 6048.758049677964, 6050.0924861269405, 6071.932719645293, 6104.816855494342, 6121.479674227562, 6185.0, 6194.0, 6195.504359651127, 6200.3489633589625, 6209.441150296495, 5804.796832110856, 5923.851903702442, 6005.939940600713, 6057.1519987200945, 6063.151158837854], "value": 5694.303282398327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.61731849157655, 507.8984203159369, 529.9788008479663, 532.9840104796857, 548.3995025447136, 29959.0, 31042.379152416965, 41325.173496530086, 42080.737577872635, 42286.577134228646, 39889.40165897514, 43397.0, 43460.0, 43510.782446087804, 43512.78243608785, 9506.904930950706, 9687.660931867385, 9690.0, 9690.515474226295, 9712.562934667922, 8726.912730872673, 8935.865962010575, 11925.22486038409, 12249.755004899896, 12262.202956807823, 12198.39008049594, 12241.449134788956, 12262.69343266421, 12280.263184208932, 12284.938575307156, 8778.341624378134, 12170.695732606668, 12237.632871013884, 12246.0815438842, 12248.142630015902, 8803.603837827313, 9000.819983600291, 9003.594838232295, 9669.516524173763, 11992.220505667105, 41133.38299925504, 41497.37753933663, 41503.7924810374, 41633.58366416327, 41633.583664163576, 3372.8482218300237, 3386.9491957620658, 3495.1262184453885, 3602.35157671619, 3681.7790932543867, 30477.0, 31733.598409542745, 32644.6735532644, 32730.0, 32737.017889463354, 3291.8024918504966, 3376.1897144685345, 3435.158386195373, 3446.87935922244, 3448.137965508623, 499000.0, 506187.0, 508310.0, 508521.0, 508996.0, 56568.02011929563, 61928.38071619316, 62575.37424625696, 62582.061269081, 62583.0, 61135.694321528106, 65481.672591636736, 65517.67241163859, 65640.34359656437, 65812.67093664597, 15178.31697573612, 16723.91638041802, 16998.98006119637, 17029.23368448423, 17040.31838726462, 11738.76522469563, 12014.399280035963, 12020.699482512833, 12671.303078330597, 12989.610311690665, 16179.514614561347, 18864.15111319994, 19194.520136996685, 19203.32788352401, 19228.71156932647, 5018.146915024455, 7885.211478852184, 7902.3678105751405, 8036.236557527026, 8046.316063134582, 898.7842917699705, 991.2268430624125, 1001.5493028137367, 1033.390299723167, 1059.613241166984, 28777.0, 30634.234144146576, 30818.075457736304, 31031.844840776103, 31193.532097018564, 1073.5115522437272, 1089.967300980972, 1107.8670559532907, 1148.322489731046, 1261.1991385470292, 15075.321610527553, 15858.52424427269, 15991.840081599268, 16049.759253611206, 16321.265543050591, 633088.0, 646593.0, 651713.0, 652272.0795940228, 652430.0, 57273.99999999916, 60200.0, 60775.69612151911, 60816.0, 60984.69507652522, 1231.6982339326564, 1279.2196759976407, 1370.7738223193262, 1406.908550944206, 1441.8630230128122, 30653.0, 30706.078817635505, 30818.383632327677, 31465.0, 32214.35571288608, 46157.0, 46484.837879053295, 46544.53455465402, 46669.53330466652, 46776.532234677215, 471918.0, 472356.0, 472916.0, 473366.0, 474664.0, 21809.469634886067, 24076.75923240745, 24108.0, 24956.253062285465, 24961.0, 38636.420453693776, 45151.54848451474, 45299.0, 46447.83880402882, 46781.766091169324, 39329.803350983064, 39822.2035559293, 40089.59910400975, 40900.1819963605, 40935.38596921108, 39617.60382396254, 39813.0, 39878.00609969548, 40910.38634420546, 41007.0, 37579.436308455945, 38244.426333605574, 38613.80693096516, 38785.80607096946, 38974.02564935899, 32212.0, 34584.82707586446, 35272.0, 35382.0, 35539.644603553636, 21752.341228066027, 25335.0, 25647.87176064108, 25985.480290394466, 26127.477450451264], "value": 20310.956663101875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.89813615070267, 346.74514232039456, 357.7442128877855, 367.5956447907302, 386.6346302743908, 15919.681606367865, 18625.161867715953, 21404.785952140475, 22100.336989890307, 22117.557648847054, 20715.37853864383, 21237.893810530924, 21274.680879786814, 21457.785422145775, 22437.0, 5362.383325917511, 5826.563007774424, 6078.787242446515, 6100.908486372708, 6109.725062372182, 5051.898962020758, 5996.310424301196, 6088.1476593276975, 6108.0, 6116.08258761185, 6053.606515576495, 6055.27336719592, 7466.066741657293, 7859.68561257549, 7871.173526779691, 7579.431542634325, 7844.882326765103, 7889.605519723991, 7933.008373953256, 7942.801429964268, 7602.163761986177, 7612.733554325572, 7621.314081732615, 7626.9618651906385, 7628.771136865903, 28680.426391472054, 29992.55011174834, 30183.396332073236, 30208.09375718732, 30708.53937190944, 2307.204014614955, 2326.0, 2466.2354670052164, 2980.0, 3476.947845782315, 12575.874241257654, 16932.492025239262, 17243.568910777332, 17905.0, 17933.316009354934, 1917.5685470768965, 1982.4250967219489, 2003.5492014296813, 2027.2600500817243, 2043.5095577061547, 134413.32793336068, 134913.0, 140694.0, 142258.0, 142858.42849429068, 18992.542535537985, 19683.507912302022, 21770.23804166878, 21811.781882180974, 21960.670589941165, 35881.0, 35926.82036589853, 35949.56201751953, 35982.640173598455, 36037.0, 9956.402615842928, 10826.133909287239, 10857.34855908648, 11093.778124437466, 11105.222634415513, 9058.139476749699, 9069.31980101495, 9076.364654474124, 9204.585793639302, 9212.0, 9478.099580539838, 9605.567749451291, 9809.362391444532, 9820.263480239011, 9822.65620703272, 2947.277916910328, 3178.49144136937, 3625.546806649169, 3732.925341493155, 3742.4573436851506, 871.1375738019316, 938.648006997376, 967.3567077893122, 1005.9295849290479, 1017.4759998600726, 21304.680429793567, 21995.560088798135, 22038.669419958715, 22073.779262207492, 22097.337079887628, 831.4263158420671, 937.5827756648226, 945.7257395355407, 945.9452710228184, 956.4309236004566, 11094.778104437866, 11429.199956003165, 11536.884631153749, 11539.307641541534, 11560.24858384219, 579864.0, 586544.0, 593757.0312148412, 594167.0, 601232.0, 129433.35283323523, 130501.34749326193, 130794.0, 131388.3722325548, 133753.3312333432, 966.8066386722684, 980.8528720691811, 982.0572250639466, 1002.4035698759227, 1003.7992401519725, 18591.256349745858, 18893.90553047226, 19077.236910523425, 19204.0, 19226.230950761812, 40761.0, 51716.15561144173, 52682.0, 53519.732401337744, 53910.730446347516, 76429.0, 78189.0, 79583.0, 80511.59744201241, 82422.76365854636, 5763.711814409179, 7401.592912389655, 7404.0, 7431.739889104072, 7722.691092356243, 9353.906460935576, 12626.431810568363, 13088.73822523525, 13347.599572012856, 13380.0, 10791.306287328442, 11117.555297788322, 11511.712207194552, 11534.653960381202, 11595.652130436101, 11208.439578020903, 11312.095032397225, 11387.487563059516, 11501.712457188638, 11573.421328933351, 11675.182737208313, 11709.473073711533, 11747.765044699228, 11765.647030589096, 11768.764624707286, 8145.51126932386, 8218.383621228311, 8335.749927502186, 8396.866423032812, 8427.325813934747, 11407.973282404624, 11478.655640330804, 11499.73502914662, 11547.364894930859, 11554.191206615456], "value": 11030.931502060554, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.4602366160009, 1560.3368568358444, 1733.835285647863, 1869.4391682495248, 1887.5186827359014, 8236.382271329652, 8569.871451928226, 8743.0, 8748.69379571715, 8760.912390876088, 7719.189485104067, 7949.92050079499, 8307.91692083079, 8505.979282486094, 8548.273396761268, 2335.976640233597, 2365.1721897335965, 2367.7277113131954, 2371.205646108556, 2372.193454225563, 1928.4985903665079, 2281.851679640826, 2310.745817960023, 2311.179531266401, 2332.568474832153, 2080.9063592138314, 2146.796054374832, 2292.6675632033343, 2351.5061837014164, 2356.4108972756812, 1979.208316673342, 2340.707411573553, 2354.5761762882676, 2372.6203807390907, 2374.192774456693, 2338.976610233893, 2347.7065366829147, 2353.5292941411617, 2356.175338631482, 2358.0, 8733.03936566977, 8814.030456649827, 8844.292456603456, 8868.02451730309, 8885.4668719877, 5110.437851836295, 5244.737763111867, 5303.496167864047, 5306.151015837448, 5311.044012077825, 3537.0273174876857, 3562.0382496725997, 3573.160307327776, 3612.277544491112, 3619.1856832212807, 1052.4948024947992, 1054.599252284127, 1060.459165825427, 1066.9466526673634, 1075.569772091162, 11500.25248358854, 11524.59663911759, 11528.020118289955, 11543.422828858524, 11545.307281563133, 3951.249262640089, 4446.9555304447185, 4480.32795080734, 4689.085628302449, 4695.694779839299, 8350.415470916978, 9764.414135151914, 9778.853317200248, 9788.168005719594, 9792.902070979342, 5265.236540701653, 5265.710385928811, 5274.92087618686, 5278.947210527922, 5301.231321458367, 4746.43042834862, 4826.0347930414055, 4831.444383895897, 4836.371271734652, 4836.95163048365, 3366.2762506061313, 3824.8661296855034, 3871.341871881787, 3936.9960660031506, 4048.4332193492346, 1168.8013037783596, 1216.087934049463, 1263.860975292717, 1266.265565971734, 1281.2120545864414, 780.9180036096128, 889.8175873945826, 895.2971917045088, 937.5593471068587, 938.5448057692014, 5791.739371728282, 5926.407359264125, 5960.910586341209, 6011.849703757353, 6136.8772624547255, 801.8757092650649, 815.8048459007582, 906.909309069101, 947.1854205383365, 995.9402435853872, 3676.00747798093, 3822.4075268333454, 3926.5484469285825, 3990.640842324147, 4056.6551843093666, 8841.778955526035, 8910.732678019669, 10231.13035391985, 10646.988536089058, 10684.51919663617, 10479.371237725762, 10623.628173013907, 10630.893691062991, 10648.574057037631, 10666.626668066581, 7927.286544211049, 8087.5551844647935, 8145.981752280964, 8147.918520814953, 8174.0, 5762.193292939076, 5802.912956305743, 5841.415858414124, 5898.705064746831, 5952.940470595238, 9803.558839852081, 9808.754781130528, 9829.606815727291, 9881.851772223567, 9896.15882649954, 9610.327277090537, 9971.102600765966, 9991.300608957303, 10143.54354054084, 10143.64497242593, 6370.968145159244, 7421.628918554159, 7507.88738168917, 7508.849823003618, 7520.8871866920945, 6683.465322774069, 8067.556284404414, 8179.67281308741, 8219.589020549069, 8304.335653147613, 7375.963120184365, 7399.112106547249, 7416.7774966751085, 7546.811329716801, 7563.584002879675, 7175.138983322035, 7279.053723015974, 7283.672234749343, 7413.481056326005, 7416.6291685414435, 6946.722131114699, 6992.265812089658, 7005.649717514002, 7014.894776578253, 7016.228214896255, 4887.975560122177, 4999.875003124951, 5019.64862459639, 5068.974655126701, 5098.617603679665, 5043.092243396224, 5054.620903432331, 5099.23511473282, 5102.948970510396, 5171.50870667286], "value": 4524.997014972765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.79738993145077, 299.98350090745, 303.0967716205707, 309.7986308899216, 315.8894386964561, 4480.171168333861, 5392.541633961108, 5401.27082843816, 5405.945940540593, 5409.918851217235, 5106.64253502255, 5127.846164615058, 5183.393148124084, 5350.759215835287, 5446.972765136179, 3376.7298616110775, 3397.7281817454545, 4136.9864383226, 4141.440905477767, 4167.166566686675, 4136.689748268876, 4139.19285739281, 4147.7926103694845, 4163.854265100722, 4178.603032711902, 3216.9839150804332, 3649.5255616769914, 4066.369712694537, 4073.388991651246, 4124.835006599732, 4078.9796051019557, 4088.7342322749223, 4098.938515922248, 4114.300568903293, 4119.876403707894, 3535.222251104753, 3550.7869527828157, 3555.8933232003083, 3566.946495802565, 3568.4825700273573, 4983.950160498385, 5298.947010529922, 5313.521783039545, 5393.946060539383, 5407.297051383334, 4677.695949763254, 4704.435467743859, 4716.316134160562, 4735.171345014609, 4750.12122757291, 5572.804951826707, 5742.966266072105, 5756.380846714776, 5764.7117644117625, 5766.424816613684, 3280.7539434542505, 3528.7177025837873, 3803.8574049283666, 3912.921741565181, 3915.7846318452757, 5219.8434046978655, 5934.495567876736, 5968.432998865101, 5989.55078369124, 5994.730237139339, 3605.94591081134, 3630.2920930418845, 3942.1918506706056, 3971.5035620547433, 3990.7605543667473, 3784.262068896594, 3874.0, 4030.7984600769846, 4034.536028356718, 4056.959430405658, 4127.195196936628, 4180.665546756252, 4488.835371063393, 4534.6372290216705, 4717.882052948635, 4788.090262850047, 5766.433936898124, 5815.941840581625, 5877.823665290048, 5896.380880007623, 1150.8676502202186, 1351.6620844788804, 1370.1436602123672, 1372.8901687865146, 1390.2978995607155, 767.8809784483414, 825.6078362777632, 834.4729145663422, 859.6604341285157, 918.8713580098791, 4452.532484089189, 5320.467953204648, 5352.91970620441, 5359.356877174764, 5363.919541206885, 5773.942260577424, 5874.706264686749, 5912.586118971717, 5922.482944748464, 5972.910406343908, 4551.40831691878, 5239.711815850165, 5346.518813306821, 5357.866053348697, 5371.838844834661, 2760.4479104179245, 3092.6752690967123, 3111.81329120249, 3119.53207018949, 3131.9530207046914, 5218.765155568009, 5230.450802665665, 5515.669059856341, 5946.0, 6056.909146362808, 6023.367546407651, 6024.698765061729, 6043.917602023, 6056.878862422727, 6081.0270356743595, 5420.186971954317, 5945.494632956247, 6077.878442431127, 6111.938880611226, 6114.266288045463, 5616.831495055155, 5822.650640961556, 5855.0, 5855.23881895368, 5889.440503152194, 4742.288656701522, 5362.0, 5383.7846486140115, 5724.284464441945, 5730.169125476699, 4846.636502262415, 5933.940660593512, 6039.667818270037, 6047.48596369296, 6069.150318955261, 3417.9746076177544, 3893.377059670439, 3913.882583522499, 3922.9607703922597, 3934.744241624285, 5402.864928376822, 5632.493075623213, 5807.60617451817, 5825.766969321349, 5866.794662186803, 4700.976495117503, 5285.036222832875, 5703.258576385043, 5716.914246286392, 5742.339630942328, 4672.509386514503, 5649.350324712711, 5680.573956953162, 5684.459976302244, 5733.856653583527, 4700.485240396371, 5342.519173274424, 5507.779688812403, 5549.278593782782, 5654.293213348332, 5470.0, 5654.802081927113, 5700.800471983461, 5742.540596752333, 5768.451997060272, 5448.591355648263, 5600.047991841316, 5646.181303711021, 5649.406812284651, 5732.942670573241], "value": 4152.481150280474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.4658632732288, 735.779266220134, 739.5267029101376, 790.3282210121398, 816.6733306677324, 15445.22773861308, 16339.428120015802, 16406.343746250135, 16418.097004664753, 16420.178991050445, 12257.877421225785, 14594.124352538855, 14798.556043318691, 15428.922855385736, 15886.205689715496, 686.800827759949, 713.2047766740073, 850.8766228896807, 883.2227639677075, 887.5384799904047, 839.9790005249856, 859.7936495241129, 860.2043110123111, 860.4149178558578, 863.5854789700948, 717.8456631824157, 888.6934007767343, 906.6418764587984, 910.899801021887, 912.7216199059284, 879.1647934462254, 887.1128871128872, 888.4402826219473, 890.1543533643065, 890.2922176869405, 673.2930423055772, 673.7439772886321, 675.2369822101043, 675.530506298123, 678.4301187002892, 14719.852801471956, 14780.334884930204, 14867.330970106372, 14882.702345953021, 15054.322555485029, 14250.358733857001, 14306.0, 14336.42654293827, 14427.639309017253, 14442.266927968605, 12909.0, 13205.20768753878, 13211.339433028406, 13304.534341298106, 13531.932340338333, 4552.772361381918, 4816.56650901417, 4842.539958703917, 4870.512948705136, 4876.902461950741, 112690.43654781756, 112852.87147128506, 112945.87054129518, 113153.43423282914, 113345.0, 9881.456519891475, 11272.887271127183, 11300.886991129983, 11495.195336326376, 11509.884901150881, 22761.772382276296, 22775.658365124535, 22796.202132925268, 22796.886015569817, 22808.315750527177, 8008.559529225832, 8024.83950321002, 8059.113497515269, 8079.717209897625, 8300.543470109082, 4471.642268618502, 4545.659075569345, 4577.977110114494, 4709.222978208557, 4723.7401942893475, 3423.554937858112, 3580.3197392495863, 3586.479960405779, 3586.8206589670936, 3587.3722098633157, 644.8258970078052, 647.6340867409898, 655.9737610495526, 658.8748137853793, 670.5674839728446, 639.8304449320933, 659.85153340498, 672.586359388982, 688.2841844481783, 692.2592825676578, 9310.0, 9321.766955826159, 9628.566714497865, 9630.614775408905, 9641.758956026155, 550.6806052489627, 595.3748564007775, 632.4655665962255, 664.5182242873974, 671.8152508060225, 4555.544445555418, 4580.221362368338, 4613.423322084739, 4624.583787459145, 4634.814607415666, 150299.49700503075, 155329.0, 156833.0, 158885.0, 159453.20273398558, 135801.3209933944, 136211.31894340663, 136986.0, 138442.0, 141652.58347416393, 92496.53751731332, 108758.45620771845, 114711.42644286725, 114853.42573287248, 115493.42253288679, 8668.869966950375, 8696.130386961253, 9039.322050846082, 9043.095690431168, 9220.538973051187, 57684.71157644353, 59808.0, 64583.70832583416, 65162.37094072686, 68082.31917680759, 88646.0, 91147.54426228092, 92112.0, 92560.0, 101922.0, 13440.193588384729, 13485.797713034508, 13604.86395136036, 13656.93171534136, 14050.78923816164, 15010.099394036393, 15251.237438128272, 15286.388544458097, 15339.463118790789, 15769.290381932611, 13593.116447430886, 13739.158144212975, 14205.502807401692, 14381.280935952951, 14436.061655992327, 12708.536567249219, 14284.07153535017, 14286.071405358618, 14332.283385830875, 14727.631809204855, 13509.324533773075, 13847.515336963157, 14049.508267210598, 14612.707745844811, 14801.0, 11209.943950280196, 11314.434278286217, 11386.886131138583, 11442.427878606202, 11812.527498899948, 9955.900440995498, 10782.353058816496, 11301.208915375844, 11393.373364464702, 11680.649580512598], "value": 8024.939671575961, "unit": "score"}], "name": "dromaeo_css", "value": 7598.01138670901, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 113.0, 112.0, 115.0, 112.0, 113.0, 113.0, 112.0, 114.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 106.0, 159.0, 135.0, 136.0, 133.0, 108.0, 159.0, 108.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 182.0, 182.0, 184.0, 182.0, 258.0, 194.0, 183.0, 184.0], "value": 191.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 57.0, 107.0, 57.0, 56.0, 61.0, 59.0, 98.0, 57.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 94.0, 70.0, 74.0, 69.0, 92.0, 68.0, 68.0, 97.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 101.0, 118.0, 84.0, 87.0, 84.0, 90.0, 86.0, 88.0, 84.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 92.0, 93.0, 94.0, 94.0, 123.0, 150.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 89.0, 87.0, 86.0, 85.0, 85.0, 83.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 54.0, 55.0, 56.0, 55.0, 52.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 80.0, 76.0, 70.0, 71.0, 68.0, 71.0, 69.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 81.0, 85.0, 86.0, 88.0, 100.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 155.0, 137.0, 144.0, 125.0, 142.0, 142.0, 152.0, 125.0, 128.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 163.0, 162.0, 156.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 79.0, 87.0, 87.0, 85.0, 72.0, 64.0, 65.0, 66.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1448.7000000000003, "alertThreshold": 2.0}]} 01:04:21 INFO - Return code: 0 01:04:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:04:21 INFO - # TBPL SUCCESS # 01:04:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:04:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:04:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:04:21 INFO - 2016-06-30 01:04:21.312 screenresolution[1957:19622] starting screenresolution argv=screenresolution get 01:04:21 INFO - 2016-06-30 01:04:21.315 screenresolution[1957:19622] Display 0: 1600x1200x32@60 01:04:21 INFO - 2016-06-30 01:04:21.321 screenresolution[1958:19625] starting screenresolution argv=screenresolution list 01:04:21 INFO - Available Modes on Display 0 01:04:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:04:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:04:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:04:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:04:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:04:21 INFO - Intel Iris: 01:04:21 INFO - Chipset Model: Intel Iris 01:04:21 INFO - Type: GPU 01:04:21 INFO - Bus: Built-In 01:04:21 INFO - VRAM (Dynamic, Max): 1536 MB 01:04:21 INFO - Vendor: Intel (0x8086) 01:04:21 INFO - Device ID: 0x0a2e 01:04:21 INFO - Revision ID: 0x0009 01:04:21 INFO - Displays: 01:04:21 INFO - Display: 01:04:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:04:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:04:21 INFO - Display Serial Number: 1600x1200 60 01:04:21 INFO - Main Display: Yes 01:04:21 INFO - Mirror: Off 01:04:21 INFO - Online: Yes 01:04:21 INFO - Rotation: Supported 01:04:21 INFO - Return code: 0 01:04:21 INFO - Running post-action listener: _resource_record_post_action 01:04:21 INFO - ##### 01:04:21 INFO - ##### Finished run-tests step (success) 01:04:21 INFO - ##### 01:04:21 INFO - Running post-run listener: _resource_record_post_run 01:04:21 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 675840; Write bytes: 704378368; Read time: 5; Write time: 1915 01:04:21 INFO - TinderboxPrint: CPU usage
53.3% 01:04:21 INFO - TinderboxPrint: I/O read bytes / time
675,840 / 5 01:04:21 INFO - TinderboxPrint: I/O write bytes / time
704,378,368 / 1,915 01:04:21 INFO - TinderboxPrint: CPU idle
2,257.1 (46.7%) 01:04:21 INFO - TinderboxPrint: CPU system
961.0 (19.9%) 01:04:21 INFO - TinderboxPrint: CPU user
1,619.5 (33.5%) 01:04:21 INFO - TinderboxPrint: Swap in / out
407,457,792 / 0 01:04:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402473472; Write bytes: 398481408; Read time: 29599; Write time: 807 01:04:21 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 638976; Write bytes: 292085248; Read time: 5; Write time: 1067 01:04:22 INFO - Running post-run listener: _upload_blobber_files 01:04:22 INFO - Blob upload gear active. 01:04:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:04:22 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 01:04:22 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:04:22 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:04:22 INFO - (blobuploader) - INFO - Open directory for files ... 01:04:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:04:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:04:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:04:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:04:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:04:23 INFO - (blobuploader) - INFO - Done attempting. 01:04:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:04:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:04:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:04:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:04:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:04:24 INFO - (blobuploader) - INFO - Done attempting. 01:04:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:04:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:04:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:04:28 INFO - (blobuploader) - INFO - Done attempting. 01:04:28 INFO - (blobuploader) - INFO - Iteration through files over. 01:04:28 INFO - Return code: 0 01:04:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:04:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:04:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71445e3c2df938f90f874bca5866f75a662bc85e938daccabc0c566b062e880fbb9cbb1bed998ec601bef57a4446a236581094e62eeefd72bb0ca979c6604a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63f0d4d30da77b547a4f5c7c1f0eb6e4dbaf0f25c00563715c3eabcc55895a94a375e0580149dc40297a88fde0aae5b158916c29b169f05f3cfc19e0503028e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d33b7305b933127ad5fe634bd95852651694db8a8ad5be222db09cffb1cf48cd19eaf418d68ac65bb31039d1160c6876946ffaf4bc5c1e3ec0ba94e38a37953"} 01:04:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:04:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:04:28 INFO - Contents: 01:04:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71445e3c2df938f90f874bca5866f75a662bc85e938daccabc0c566b062e880fbb9cbb1bed998ec601bef57a4446a236581094e62eeefd72bb0ca979c6604a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63f0d4d30da77b547a4f5c7c1f0eb6e4dbaf0f25c00563715c3eabcc55895a94a375e0580149dc40297a88fde0aae5b158916c29b169f05f3cfc19e0503028e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d33b7305b933127ad5fe634bd95852651694db8a8ad5be222db09cffb1cf48cd19eaf418d68ac65bb31039d1160c6876946ffaf4bc5c1e3ec0ba94e38a37953"} 01:04:28 INFO - Running post-run listener: copy_logs_to_upload_dir 01:04:28 INFO - Copying logs to upload dir... 01:04:28 INFO - mkdir: /builds/slave/test/build/upload/logs 01:04:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.142453 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-06-30 01:04:28.531442) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 01:04:28.535114) ========= 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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71445e3c2df938f90f874bca5866f75a662bc85e938daccabc0c566b062e880fbb9cbb1bed998ec601bef57a4446a236581094e62eeefd72bb0ca979c6604a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63f0d4d30da77b547a4f5c7c1f0eb6e4dbaf0f25c00563715c3eabcc55895a94a375e0580149dc40297a88fde0aae5b158916c29b169f05f3cfc19e0503028e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d33b7305b933127ad5fe634bd95852651694db8a8ad5be222db09cffb1cf48cd19eaf418d68ac65bb31039d1160c6876946ffaf4bc5c1e3ec0ba94e38a37953"} build_url:https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/CARRk6cjTuy3Q94L49YLFQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71445e3c2df938f90f874bca5866f75a662bc85e938daccabc0c566b062e880fbb9cbb1bed998ec601bef57a4446a236581094e62eeefd72bb0ca979c6604a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63f0d4d30da77b547a4f5c7c1f0eb6e4dbaf0f25c00563715c3eabcc55895a94a375e0580149dc40297a88fde0aae5b158916c29b169f05f3cfc19e0503028e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d33b7305b933127ad5fe634bd95852651694db8a8ad5be222db09cffb1cf48cd19eaf418d68ac65bb31039d1160c6876946ffaf4bc5c1e3ec0ba94e38a37953"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 01:04:28.567825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:04:28.568127) ========= 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.rjrTjYqEIq/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.VUW5JK1Wte/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.005151 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:04:28.616548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 01:04:28.616862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 01:04:28.617161) ========= ========= Total master_lag: 0.18 =========