builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0197 starttime: 1467299098.06 results: success (0) buildid: 20160630053228 builduid: 9aa9674ecdc0499888001686ce1d7ce3 revision: 88250e019f258cdd6877f01fa64e9cf957b24f50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.058563) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.064651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.064985) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.109159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.109582) ========= 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.4ws3T3TsJp/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.KAew8qA1kv/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:04: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% 163M=0s 2016-06-30 08:04:58 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.644445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.775826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.776134) ========= 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.4ws3T3TsJp/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.KAew8qA1kv/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.018937 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:04:58.824202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-30 08:04:58.824526) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 88250e019f258cdd6877f01fa64e9cf957b24f50 --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 88250e019f258cdd6877f01fa64e9cf957b24f50 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ws3T3TsJp/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.KAew8qA1kv/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:04:58,892 truncating revision to first 12 chars 2016-06-30 08:04:58,892 Setting DEBUG logging. 2016-06-30 08:04:58,892 attempt 1/10 2016-06-30 08:04:58,892 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/88250e019f25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 08:05:00,962 unpacking tar archive at: fx-team-88250e019f25/testing/mozharness/ program finished with exit code 0 elapsedTime=2.331369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-30 08:05:01.177537) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 08:05:01.177904) ========= script_repo_revision: 88250e019f258cdd6877f01fa64e9cf957b24f50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 08:05:01.178308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 08:05:01.178580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 08:05:01.196723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-30 08:05:01.197119) ========= /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.4ws3T3TsJp/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.KAew8qA1kv/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:01 INFO - MultiFileLogger online at 20160630 08:05:01 in /builds/slave/test 08:05:01 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 08:05:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:01 INFO - {'append_to_log': False, 08:05:01 INFO - 'base_work_dir': '/builds/slave/test', 08:05:01 INFO - 'blob_upload_branch': 'Fx-Team', 08:05:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:01 INFO - 'branch': 'Fx-Team', 08:05:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:01 INFO - 'config_files': ('talos/mac_config.py',), 08:05:01 INFO - 'default_actions': ('clobber', 08:05:01 INFO - 'read-buildbot-config', 08:05:01 INFO - 'download-and-extract', 08:05:01 INFO - 'populate-webroot', 08:05:01 INFO - 'create-virtualenv', 08:05:01 INFO - 'install', 08:05:01 INFO - 'run-tests'), 08:05:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:01 INFO - 'download_minidump_stackwalk': True, 08:05:01 INFO - 'download_symbols': 'ondemand', 08:05:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:01 INFO - 'installer_path': 'installer.exe', 08:05:01 INFO - 'log_level': 'info', 08:05:01 INFO - 'log_name': 'talos', 08:05:01 INFO - 'log_to_console': True, 08:05:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:05:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:05:01 INFO - 'opt_config_files': (), 08:05:01 INFO - 'pip_index': False, 08:05:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:05:01 INFO - 'cmd': ('bash', 08:05:01 INFO - '-c', 08:05:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:05:01 INFO - 'enabled': True, 08:05:01 INFO - 'halt_on_failure': False, 08:05:01 INFO - 'name': 'check_screen_resolution'},), 08:05:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:05:01 INFO - 'cmd': ('bash', 08:05:01 INFO - '-c', 08:05:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:05:01 INFO - 'enabled': True, 08:05:01 INFO - 'halt_on_failure': False, 08:05:01 INFO - 'name': 'check_screen_resolution'},), 08:05:01 INFO - 'run_cmd_checks_enabled': True, 08:05:01 INFO - 'sps_profile': False, 08:05:01 INFO - 'sps_profile_interval': 0, 08:05:01 INFO - 'suite': 'dromaeojs', 08:05:01 INFO - 'system_bits': '32', 08:05:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:01 INFO - 'title': 't-yosemite-r7-0197', 08:05:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:01 INFO - 'use_talos_json': True, 08:05:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:01 INFO - 'work_dir': 'build'} 08:05:01 INFO - ##### 08:05:01 INFO - ##### Running clobber step. 08:05:01 INFO - ##### 08:05:01 INFO - Running pre-action listener: _resource_record_pre_action 08:05:01 INFO - Running main action method: clobber 08:05:01 INFO - rmtree: /builds/slave/test/build 08:05:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:03 INFO - Running post-action listener: _resource_record_post_action 08:05:03 INFO - ##### 08:05:03 INFO - ##### Finished clobber step (success) 08:05:03 INFO - ##### 08:05:03 INFO - ##### 08:05:03 INFO - ##### Running read-buildbot-config step. 08:05:03 INFO - ##### 08:05:03 INFO - Running pre-action listener: _resource_record_pre_action 08:05:03 INFO - Running main action method: read_buildbot_config 08:05:03 INFO - Using buildbot properties: 08:05:03 INFO - { 08:05:03 INFO - "project": "", 08:05:03 INFO - "product": "firefox", 08:05:03 INFO - "script_repo_revision": "production", 08:05:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:05:03 INFO - "repository": "", 08:05:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:05:03 INFO - "buildid": "20160630053228", 08:05:03 INFO - "pgo_build": "False", 08:05:03 INFO - "basedir": "/builds/slave/test", 08:05:03 INFO - "buildnumber": 83, 08:05:03 INFO - "slavename": "t-yosemite-r7-0197", 08:05:03 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:05:03 INFO - "platform": "yosemite_r7", 08:05:03 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:05:03 INFO - "branch": "fx-team", 08:05:03 INFO - "repo_path": "integration/fx-team", 08:05:03 INFO - "revision": "88250e019f258cdd6877f01fa64e9cf957b24f50", 08:05:03 INFO - "stage_platform": "macosx64", 08:05:03 INFO - "builduid": "9aa9674ecdc0499888001686ce1d7ce3", 08:05:03 INFO - "slavebuilddir": "test" 08:05:03 INFO - } 08:05:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 08:05:03 INFO - Running post-action listener: _resource_record_post_action 08:05:03 INFO - ##### 08:05:03 INFO - ##### Finished read-buildbot-config step (success) 08:05:03 INFO - ##### 08:05:03 INFO - ##### 08:05:03 INFO - ##### Running download-and-extract step. 08:05:03 INFO - ##### 08:05:03 INFO - Running pre-action listener: _resource_record_pre_action 08:05:03 INFO - Running main action method: download_and_extract 08:05:03 INFO - mkdir: /builds/slave/test/build/tests 08:05:03 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')]} 08:05:03 INFO - https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:05:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:05:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:05:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:07 INFO - Downloaded 1199 bytes. 08:05:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 08:05:07 INFO - Using the following test package requirements: 08:05:07 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:05:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 08:05:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 08:05:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'jsshell-mac.zip'], 08:05:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 08:05:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:05:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 08:05:07 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 08:05:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 08:05:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 08:05:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:05:07 INFO - https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:10 INFO - Downloaded 18788766 bytes. 08:05:10 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'] 08:05:10 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 08:05:13 INFO - Return code: 0 08:05:13 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 08:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:13 INFO - https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:05:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:05:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:05:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:15 INFO - Downloaded 18788766 bytes. 08:05:15 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'] 08:05:15 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 08:05:18 INFO - Return code: 0 08:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:05:18 INFO - https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:20 INFO - Downloaded 14405242 bytes. 08:05:20 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'] 08:05:20 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 08:05:20 INFO - Return code: 0 08:05:20 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')]} 08:05:20 INFO - https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 08:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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 08:05:24 INFO - Downloaded 112415149 bytes. 08:05:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:05:24 INFO - mkdir: /builds/slave/test/properties 08:05:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:24 INFO - Contents: 08:05:24 INFO - build_url:https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:05:25 INFO - Running post-action listener: _resource_record_post_action 08:05:25 INFO - Running post-action listener: set_extra_try_arguments 08:05:25 INFO - ##### 08:05:25 INFO - ##### Finished download-and-extract step (success) 08:05:25 INFO - ##### 08:05:25 INFO - ##### 08:05:25 INFO - ##### Running populate-webroot step. 08:05:25 INFO - ##### 08:05:25 INFO - Running pre-action listener: _resource_record_pre_action 08:05:25 INFO - Running main action method: populate_webroot 08:05:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:25 INFO - '--tppagecycles', 08:05:25 INFO - '7'], 08:05:25 INFO - 'tests': ['tsvgm']}}, 08:05:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['damp', 'tps']}, 08:05:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'tests': ['damp', 'tps']}, 08:05:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['dromaeo_dom']}, 08:05:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['basic_compositor_video']}, 08:05:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['a11yr', 08:05:25 INFO - 'ts_paint', 08:05:25 INFO - 'tpaint', 08:05:25 INFO - 'sessionrestore', 08:05:25 INFO - 'sessionrestore_no_auto_restore', 08:05:25 INFO - 'tabpaint']}, 08:05:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:25 INFO - 'ts_paint', 08:05:25 INFO - 'tpaint', 08:05:25 INFO - 'sessionrestore', 08:05:25 INFO - 'sessionrestore_no_auto_restore', 08:05:25 INFO - 'tabpaint']}, 08:05:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:25 INFO - 'ts_paint', 08:05:25 INFO - 'tpaint', 08:05:25 INFO - 'sessionrestore', 08:05:25 INFO - 'sessionrestore_no_auto_restore', 08:05:25 INFO - 'tabpaint']}, 08:05:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:25 INFO - 'ts_paint', 08:05:25 INFO - 'tpaint', 08:05:25 INFO - 'sessionrestore', 08:05:25 INFO - 'sessionrestore_no_auto_restore', 08:05:25 INFO - 'tabpaint']}, 08:05:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['a11yr', 08:05:25 INFO - 'ts_paint', 08:05:25 INFO - 'tpaint', 08:05:25 INFO - 'sessionrestore', 08:05:25 INFO - 'sessionrestore_no_auto_restore', 08:05:25 INFO - 'tabpaint']}, 08:05:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['a11yr', 08:05:25 INFO - 'ts_paint', 08:05:25 INFO - 'tpaint', 08:05:25 INFO - 'sessionrestore', 08:05:25 INFO - 'sessionrestore_no_auto_restore', 08:05:25 INFO - 'tabpaint']}, 08:05:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['tsvgx', 08:05:25 INFO - 'tsvgr_opacity', 08:05:25 INFO - 'tart', 08:05:25 INFO - 'tscrollx', 08:05:25 INFO - 'cart']}, 08:05:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:25 INFO - 'tsvgr_opacity', 08:05:25 INFO - 'tart', 08:05:25 INFO - 'tscrollx', 08:05:25 INFO - 'cart']}, 08:05:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'talos_options': ['--disable-e10s'], 08:05:25 INFO - 'tests': ['tp5o']}, 08:05:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'tests': ['tp5o']}, 08:05:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'talos_options': ['--disable-e10s', 08:05:25 INFO - '--xperf_path', 08:05:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:25 INFO - 'tests': ['tp5n']}, 08:05:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:25 INFO - 'talos_options': ['--xperf_path', 08:05:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:25 INFO - 'tests': ['tp5n']}}, 08:05:25 INFO - 'talos.zip': {'path': '', 08:05:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:25 INFO - Running post-action listener: _resource_record_post_action 08:05:25 INFO - ##### 08:05:25 INFO - ##### Finished populate-webroot step (success) 08:05:25 INFO - ##### 08:05:25 INFO - ##### 08:05:25 INFO - ##### Running create-virtualenv step. 08:05:25 INFO - ##### 08:05:25 INFO - Running pre-action listener: _resource_record_pre_action 08:05:25 INFO - Running main action method: create_virtualenv 08:05:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:25 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 08:05:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:25 INFO - Using real prefix '/tools/python27' 08:05:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:29 INFO - Installing pip.................done. 08:05:29 INFO - Return code: 0 08:05:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:29 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')]} 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 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')]} 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 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 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:29 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 08:05:29 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 08:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:29 INFO - 'HOME': '/Users/cltbld', 08:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:29 INFO - 'LOGNAME': 'cltbld', 08:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:29 INFO - 'MOZ_NO_REMOTE': '1', 08:05:29 INFO - 'NO_EM_RESTART': '1', 08:05:29 INFO - 'PAGER': '/bin/cat', 08:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:29 INFO - 'PWD': '/builds/slave/test', 08:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:29 INFO - 'SHELL': '/bin/bash', 08:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:29 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:29 INFO - 'USER': 'cltbld', 08:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:29 INFO - 'XPC_FLAGS': '0x0', 08:05:29 INFO - 'XPC_SERVICE_NAME': '0', 08:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:29 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 08:05:29 INFO - Cleaning up... 08:05:29 INFO - Return code: 0 08:05:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:29 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')]} 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 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')]} 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:29 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 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:29 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 08:05:29 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 08:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:29 INFO - 'HOME': '/Users/cltbld', 08:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:29 INFO - 'LOGNAME': 'cltbld', 08:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:29 INFO - 'MOZ_NO_REMOTE': '1', 08:05:29 INFO - 'NO_EM_RESTART': '1', 08:05:29 INFO - 'PAGER': '/bin/cat', 08:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:29 INFO - 'PWD': '/builds/slave/test', 08:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:29 INFO - 'SHELL': '/bin/bash', 08:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:29 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:29 INFO - 'USER': 'cltbld', 08:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:29 INFO - 'XPC_FLAGS': '0x0', 08:05:29 INFO - 'XPC_SERVICE_NAME': '0', 08:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:29 INFO - Downloading/unpacking psutil>=3.1.1 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:33 INFO - Installing collected packages: psutil 08:05:33 INFO - Running setup.py install for psutil 08:05:33 INFO - building 'psutil._psutil_osx' extension 08:05:33 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 08:05:33 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 08:05:33 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 08:05:33 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 08:05:33 INFO - building 'psutil._psutil_posix' extension 08:05:33 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 08:05:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:05:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:05:33 INFO - ^ 08:05:33 INFO - 1 warning generated. 08:05:33 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 08:05:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:34 INFO - Successfully installed psutil 08:05:34 INFO - Cleaning up... 08:05:34 INFO - Return code: 0 08:05:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:34 INFO - 'HOME': '/Users/cltbld', 08:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:34 INFO - 'LOGNAME': 'cltbld', 08:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:34 INFO - 'MOZ_NO_REMOTE': '1', 08:05:34 INFO - 'NO_EM_RESTART': '1', 08:05:34 INFO - 'PAGER': '/bin/cat', 08:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:34 INFO - 'PWD': '/builds/slave/test', 08:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:34 INFO - 'SHELL': '/bin/bash', 08:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:34 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:34 INFO - 'USER': 'cltbld', 08:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:34 INFO - 'XPC_FLAGS': '0x0', 08:05:34 INFO - 'XPC_SERVICE_NAME': '0', 08:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:36 INFO - Installing collected packages: mozsystemmonitor 08:05:36 INFO - Running setup.py install for mozsystemmonitor 08:05:37 INFO - Successfully installed mozsystemmonitor 08:05:37 INFO - Cleaning up... 08:05:37 INFO - Return code: 0 08:05:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:37 INFO - 'HOME': '/Users/cltbld', 08:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:37 INFO - 'LOGNAME': 'cltbld', 08:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:37 INFO - 'MOZ_NO_REMOTE': '1', 08:05:37 INFO - 'NO_EM_RESTART': '1', 08:05:37 INFO - 'PAGER': '/bin/cat', 08:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:37 INFO - 'PWD': '/builds/slave/test', 08:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:37 INFO - 'SHELL': '/bin/bash', 08:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:37 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:37 INFO - 'USER': 'cltbld', 08:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:37 INFO - 'XPC_FLAGS': '0x0', 08:05:37 INFO - 'XPC_SERVICE_NAME': '0', 08:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:40 INFO - warning: no files found matching '*.txt' 08:05:40 INFO - no previously-included directories found matching 'build' 08:05:40 INFO - no previously-included directories found matching 'dist' 08:05:40 INFO - no previously-included directories found matching '.git*' 08:05:40 INFO - Installing collected packages: jsonschema, functools32 08:05:40 INFO - Running setup.py install for functools32 08:05:40 INFO - warning: no files found matching '*.txt' 08:05:40 INFO - no previously-included directories found matching 'build' 08:05:40 INFO - no previously-included directories found matching 'dist' 08:05:40 INFO - no previously-included directories found matching '.git*' 08:05:40 INFO - Successfully installed jsonschema functools32 08:05:40 INFO - Cleaning up... 08:05:40 INFO - Return code: 0 08:05:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:40 INFO - 'HOME': '/Users/cltbld', 08:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:40 INFO - 'LOGNAME': 'cltbld', 08:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:40 INFO - 'MOZ_NO_REMOTE': '1', 08:05:40 INFO - 'NO_EM_RESTART': '1', 08:05:40 INFO - 'PAGER': '/bin/cat', 08:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:40 INFO - 'PWD': '/builds/slave/test', 08:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:40 INFO - 'SHELL': '/bin/bash', 08:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:40 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:40 INFO - 'USER': 'cltbld', 08:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:40 INFO - 'XPC_FLAGS': '0x0', 08:05:40 INFO - 'XPC_SERVICE_NAME': '0', 08:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:40 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 08:05:40 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 08:05:40 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 08:05:40 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 08:05:40 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 08:05:40 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 08:05:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:43 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 08:05:43 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 08:05:43 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 08:05:43 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 08:05:43 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 08:05:43 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 08:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:43 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 08:05:43 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 08:05:43 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 08:05:43 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 08:05:43 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 08:05:43 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 08:05:44 INFO - Downloading docopt-0.6.1.tar.gz 08:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:44 INFO - Running setup.py install for blobuploader 08:05:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:44 INFO - Running setup.py install for requests 08:05:45 INFO - Running setup.py install for docopt 08:05:45 INFO - Successfully installed blobuploader requests docopt 08:05:45 INFO - Cleaning up... 08:05:45 INFO - Return code: 0 08:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:45 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 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:45 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 08:05:45 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 08:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:45 INFO - 'HOME': '/Users/cltbld', 08:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:45 INFO - 'LOGNAME': 'cltbld', 08:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:45 INFO - 'MOZ_NO_REMOTE': '1', 08:05:45 INFO - 'NO_EM_RESTART': '1', 08:05:45 INFO - 'PAGER': '/bin/cat', 08:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:45 INFO - 'PWD': '/builds/slave/test', 08:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:45 INFO - 'SHELL': '/bin/bash', 08:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:45 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:45 INFO - 'USER': 'cltbld', 08:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:45 INFO - 'XPC_FLAGS': '0x0', 08:05:45 INFO - 'XPC_SERVICE_NAME': '0', 08:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:45 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-gioyNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:45 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-RriOwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:45 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-qaeI9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:45 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-zwucKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-jKMlOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-0UcmD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-GPbwFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-KHNtY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-p5QsSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-URSLAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-oTPJxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-rzyHdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:46 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-wcUz4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:47 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-aAoLzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:47 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-AiBPFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:47 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-4PjxYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:47 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Vy9vYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:47 INFO - Running setup.py install for manifestparser 08:05:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:47 INFO - Running setup.py install for mozcrash 08:05:47 INFO - Running setup.py install for mozdebug 08:05:47 INFO - Running setup.py install for mozdevice 08:05:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Running setup.py install for mozfile 08:05:48 INFO - Running setup.py install for mozhttpd 08:05:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Running setup.py install for mozinfo 08:05:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Running setup.py install for mozInstall 08:05:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Running setup.py install for mozleak 08:05:48 INFO - Running setup.py install for mozlog 08:05:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:48 INFO - Running setup.py install for moznetwork 08:05:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:49 INFO - Running setup.py install for mozprocess 08:05:49 INFO - Running setup.py install for mozprofile 08:05:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:49 INFO - Running setup.py install for mozrunner 08:05:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:49 INFO - Running setup.py install for mozscreenshot 08:05:49 INFO - Running setup.py install for moztest 08:05:49 INFO - Running setup.py install for mozversion 08:05:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:49 INFO - Cleaning up... 08:05:49 INFO - Return code: 0 08:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:49 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')]} 08:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:49 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')]} 08:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:49 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 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:49 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 08:05:49 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 08:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:49 INFO - 'HOME': '/Users/cltbld', 08:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:50 INFO - 'LOGNAME': 'cltbld', 08:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:50 INFO - 'MOZ_NO_REMOTE': '1', 08:05:50 INFO - 'NO_EM_RESTART': '1', 08:05:50 INFO - 'PAGER': '/bin/cat', 08:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:50 INFO - 'PWD': '/builds/slave/test', 08:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:50 INFO - 'SHELL': '/bin/bash', 08:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:50 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:50 INFO - 'USER': 'cltbld', 08:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:50 INFO - 'XPC_FLAGS': '0x0', 08:05:50 INFO - 'XPC_SERVICE_NAME': '0', 08:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:50 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-RcN7Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:50 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)) 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:50 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-ZU4d74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:50 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)) 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:50 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-D4vOW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:50 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)) 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:50 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-qiRZKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:50 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)) 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:50 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-2s96iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:50 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)) 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:50 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-rAMCJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:50 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)) 08:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:50 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-fMo29X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Uyz4i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-zv4f5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-kkJpb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-hfgDTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-FuqD8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-BGWCcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-b_cH6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-7gFuiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-KwHITz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:51 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)) 08:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:51 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-JeP46i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:52 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)) 08:05:52 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)) 08:05:52 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)) 08:05:52 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)) 08:05:52 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)) 08:05:52 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)) 08:05:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 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 08:05:54 INFO - Downloading blessings-1.6.tar.gz 08:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:54 INFO - Installing collected packages: blessings 08:05:54 INFO - Running setup.py install for blessings 08:05:54 INFO - Successfully installed blessings 08:05:54 INFO - Cleaning up... 08:05:54 INFO - Return code: 0 08:05:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:55 INFO - Reading from file tmpfile_stdout 08:05:55 INFO - Current package versions: 08:05:55 INFO - blessings == 1.6 08:05:55 INFO - blobuploader == 1.2.4 08:05:55 INFO - docopt == 0.6.1 08:05:55 INFO - functools32 == 3.2.3-2 08:05:55 INFO - jsonschema == 2.5.1 08:05:55 INFO - manifestparser == 1.1 08:05:55 INFO - mozInstall == 1.12 08:05:55 INFO - mozcrash == 0.17 08:05:55 INFO - mozdebug == 0.1 08:05:55 INFO - mozdevice == 0.48 08:05:55 INFO - mozfile == 1.2 08:05:55 INFO - mozhttpd == 0.7 08:05:55 INFO - mozinfo == 0.9 08:05:55 INFO - mozleak == 0.1 08:05:55 INFO - mozlog == 3.2 08:05:55 INFO - moznetwork == 0.27 08:05:55 INFO - mozprocess == 0.22 08:05:55 INFO - mozprofile == 0.28 08:05:55 INFO - mozrunner == 6.11 08:05:55 INFO - mozscreenshot == 0.1 08:05:55 INFO - mozsystemmonitor == 0.3 08:05:55 INFO - moztest == 0.7 08:05:55 INFO - mozversion == 1.4 08:05:55 INFO - psutil == 3.1.1 08:05:55 INFO - requests == 1.2.3 08:05:55 INFO - wsgiref == 0.1.2 08:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05:55 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 08:05:55 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 08:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:55 INFO - 'HOME': '/Users/cltbld', 08:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PAGER': '/bin/cat', 08:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test', 08:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:55 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - 'XPC_FLAGS': '0x0', 08:05:55 INFO - 'XPC_SERVICE_NAME': '0', 08:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 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)) 08:05:55 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d617a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6ac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b24c0890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, '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.4ws3T3TsJp/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.KAew8qA1kv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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 08:05: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', 'jsonschema'] in /builds/slave/test/build 08:05: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 jsonschema 08:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:05:55 INFO - 'HOME': '/Users/cltbld', 08:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PAGER': '/bin/cat', 08:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test', 08:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:05:55 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - 'XPC_FLAGS': '0x0', 08:05:55 INFO - 'XPC_SERVICE_NAME': '0', 08:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:55 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Running post-action listener: _resource_record_post_action 08:05:55 INFO - Running post-action listener: _start_resource_monitoring 08:05:55 INFO - Starting resource monitoring. 08:05:55 INFO - ##### 08:05:55 INFO - ##### Finished create-virtualenv step (success) 08:05:55 INFO - ##### 08:05:55 INFO - ##### 08:05:55 INFO - ##### Running install step. 08:05:55 INFO - ##### 08:05:55 INFO - Running pre-action listener: _resource_record_pre_action 08:05:55 INFO - Running main action method: install 08:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:55 INFO - Reading from file tmpfile_stdout 08:05:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:56 INFO - Reading from file tmpfile_stdout 08:05:56 INFO - Output received: 08:05:56 INFO - Usage: mozinstall [options] installer 08:05:56 INFO - Options: 08:05:56 INFO - -h, --help show this help message and exit 08:05:56 INFO - -d DEST, --destination=DEST 08:05:56 INFO - Directory to install application into. [default: 08:05:56 INFO - "/builds/slave/test"] 08:05:56 INFO - --app=APP Application being installed. [default: firefox] 08:05:56 INFO - mkdir: /builds/slave/test/build/application 08:05:56 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'] 08:05:56 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 08:06:31 INFO - Reading from file tmpfile_stdout 08:06:31 INFO - Output received: 08:06:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:06:31 INFO - Running post-action listener: _resource_record_post_action 08:06:31 INFO - ##### 08:06:31 INFO - ##### Finished install step (success) 08:06:31 INFO - ##### 08:06:31 INFO - ##### 08:06:31 INFO - ##### Running run-tests step. 08:06:31 INFO - ##### 08:06:31 INFO - Running pre-action listener: _resource_record_pre_action 08:06:31 INFO - Running main action method: run_tests 08:06:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:06:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:06:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:06:31 INFO - 2016-06-30 08:06:31.088 screenresolution[1985:11468] starting screenresolution argv=screenresolution get 08:06:31 INFO - 2016-06-30 08:06:31.090 screenresolution[1985:11468] Display 0: 1600x1200x32@60 08:06:31 INFO - 2016-06-30 08:06:31.096 screenresolution[1986:11470] starting screenresolution argv=screenresolution list 08:06:31 INFO - Available Modes on Display 0 08:06:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:06:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:06:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:06:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:06:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:06:31 INFO - Intel Iris: 08:06:31 INFO - Chipset Model: Intel Iris 08:06:31 INFO - Type: GPU 08:06:31 INFO - Bus: Built-In 08:06:31 INFO - VRAM (Dynamic, Max): 1536 MB 08:06:31 INFO - Vendor: Intel (0x8086) 08:06:31 INFO - Device ID: 0x0a2e 08:06:31 INFO - Revision ID: 0x0009 08:06:31 INFO - Displays: 08:06:31 INFO - Display: 08:06:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:06:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:06:31 INFO - Display Serial Number: 1600x1200 60 08:06:31 INFO - Main Display: Yes 08:06:31 INFO - Mirror: Off 08:06:31 INFO - Online: Yes 08:06:31 INFO - Rotation: Supported 08:06:31 INFO - Return code: 0 08:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:06:31 INFO - Python 2.7.3 08:06:31 INFO - Return code: 0 08:06:31 INFO - grabbing minidump binary from tooltool 08:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:31 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 0x10d57bd30>, '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 0x10d2e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d573b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:06:31 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 08:06:31 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 08:06:31 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 08:06:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:31 INFO - Return code: 0 08:06:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:06:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:06:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:06:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:06:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:06:31 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/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0197', '--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 08:06:31 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/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0197 --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 08:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ws3T3TsJp/Render', 08:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:06:31 INFO - 'HOME': '/Users/cltbld', 08:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:06:31 INFO - 'LOGNAME': 'cltbld', 08:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:31 INFO - 'MOZ_NO_REMOTE': '1', 08:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:31 INFO - 'NO_EM_RESTART': '1', 08:06:31 INFO - 'PAGER': '/bin/cat', 08:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:31 INFO - 'PWD': '/builds/slave/test', 08:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:06:31 INFO - 'SHELL': '/bin/bash', 08:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAew8qA1kv/Listeners', 08:06:31 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 08:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:06:31 INFO - 'USER': 'cltbld', 08:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:31 INFO - 'XPC_FLAGS': '0x0', 08:06:31 INFO - 'XPC_SERVICE_NAME': '0', 08:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:06:31 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/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0197', '--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 08:06:31 INFO - mozversion application_buildid: 20160630053228 08:06:31 INFO - mozversion application_changeset: 88250e019f258cdd6877f01fa64e9cf957b24f50 08:06:31 INFO - mozversion application_display_name: Nightly 08:06:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:31 INFO - mozversion application_name: Firefox 08:06:31 INFO - mozversion application_remotingname: firefox 08:06:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:06:31 INFO - mozversion application_vendor: Mozilla 08:06:31 INFO - mozversion application_version: 50.0a1 08:06:31 INFO - mozversion platform_buildid: 20160630053228 08:06:31 INFO - mozversion platform_changeset: 88250e019f258cdd6877f01fa64e9cf957b24f50 08:06:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:06:31 INFO - mozversion platform_version: 50.0a1 08:06:31 INFO - using testdate: 1467299191 08:06:31 INFO - actual date: 1467299191 08:06:31 INFO - starting webserver on 'localhost:49384' 08:06:31 INFO - SUITE-START | Running 2 tests 08:06:31 INFO - TEST-START | dromaeo_css 08:06:31 INFO - operating with platform_type : mac_ 08:06:31 INFO - Initialising browser for dromaeo_css test... 08:06:31 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpWYqVqH/profile http://localhost:49384/getInfo.html) 08:06:33 INFO - PROCESS | 1996 | __metrics Screen width/height:1600/1200 08:06:33 INFO - PROCESS | 1996 | colorDepth:24 08:06:33 INFO - PROCESS | 1996 | Browser inner width/height: 1024/689 08:06:33 INFO - PROCESS | 1996 | __metrics 08:06:34 INFO - PROCESS | 1996 | 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" 08:06:34 INFO - PROCESS | 1996 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:34 INFO - TEST-INFO | 1996: exit 0 08:06:34 INFO - Browser initialized. 08:06:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:34 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpWYqVqH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:46 INFO - PROCESS | 1998 | RSS: Main: 244809728 08:06:46 INFO - PROCESS | 1998 | 08:07:37 INFO - PROCESS | 1998 | 1467299257701 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] 08:09:49 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49384/tests/dromaeo/cssquery-ext.html) 08:09:50 INFO - PROCESS | 1998 | RSS: Main: 348753920 08:09:50 INFO - PROCESS | 1998 | 08:12:53 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-ext.html (next: http://localhost:49384/tests/dromaeo/cssquery-jquery.html) 08:12:54 INFO - PROCESS | 1998 | RSS: Main: 373878784 08:12:54 INFO - PROCESS | 1998 | 08:15:56 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49384/tests/dromaeo/cssquery-mootools.html) 08:15:57 INFO - PROCESS | 1998 | RSS: Main: 372379648 08:15:57 INFO - PROCESS | 1998 | 08:18:59 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49384/tests/dromaeo/cssquery-prototype.html) 08:19:00 INFO - PROCESS | 1998 | RSS: Main: 372744192 08:19:00 INFO - PROCESS | 1998 | 08:22:03 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49384/tests/dromaeo/cssquery-yui.html) 08:22:04 INFO - PROCESS | 1998 | RSS: Main: 337543168 08:22:04 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-yui.html (next: http://localhost:49384/tests/dromaeo/cssquery-dojo.html) 08:25:07 INFO - PROCESS | 1998 | RSS: Main: 392716288 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | __start_tp_report 08:25:07 INFO - PROCESS | 1998 | _x_x_mozilla_page_load 08:25:07 INFO - PROCESS | 1998 | _x_x_mozilla_page_load_details 08:25:07 INFO - PROCESS | 1998 | |i|pagename|runs| 08:25:07 INFO - PROCESS | 1998 | |0;dojo.html;3308.9172770680734;3321.518379834924;3341.4820702791067;3350.2127000154974;3381.8309084545767;5633.40849210832;5647.887042259153;5691.430856914307;5712.71436428179;5737.368889422165;5645.943540564593;5723.456271654186;5728.42715728427;5731.197632331467;5733.082706766918;5171.5862730981435;5232.686038837663;5266.289050978107;5267.683938963655;5336.17289320156;5217.660852044605;5249.632525723201;5277.445868183843;5314.973425132869;5316.175992721134;5232.3197984262;5254.894902101955;5292.947070529303;5297.523222909937;5315.946840531584;5339.492748188916;5340.572754179656;5340.732963351837;5358.2498450217;5372.811951581676;5096.694198348111;5122.462141475129;5165.509276618715;5276.604254680914;5285.709285989269;5668.603197776158;5694.77220911163;5716.485516303553;5737.77048918047;5747.798827041075;6218.284897236786;6245.375462453764;6253.218347706536;6259.530535209878;6265.8746825063245;6118.694065296718;6160.260768707739;6233.345498722614;6237;6240.500759939239;5813.302403711497;5819.185314056035;5828.679422631796;5831.3877042910735;5837.153612726131;6255.499560035186;6274.247090349188;6277.874442511215;6279.058141278753;6285.654289014056;5946.70266486674;5997.220361352996;6085.056816193497;6109.625334299747;6144.41628045335;6293.056041593798;6304.05439184126;6304.590201636879;6315.052742088724;6322.956712142537;6139.938600613937;6229.501639868799;6231.844203894939;6246.531510136667;6262.499000079983;6114.144019837227;6135.01831721223;6146.784862529879;6195.876082478325;6250.093736408196;4941.654084214142;4977.601791856643;4980.228064649985;4988.8752781180765;4994.500549945049;4430.911381772346;4463.933041004388;4466.218411777926;4520;4584.541545845455;5724.055530837365;5728.885422291531;5739.397363276879;5752.13717942312;5797.652140871562;6107.370879189147;6253.5622506425025;6312.463440607508;6325.05124231369;6340.873182536324;5611.5230205433;5625.409332020161;5668.773249070074;5696.088625819849;5709.286339207599;5421.322334708161;5432.456754324536;5436.972815135899;5448.482394172547;5471.863203419946;6218.502519798496;6271.529635277281;6287.842803929847;6291.622502649764;6307.306196318493;6113.050656958906;6158.3225845157895;6167.414095660905;6217.222847144107;6266.185395898504;6209.627422354673;6253.093301471352;6254.186955695731;6269.5611307208055;6286.119943207863;6159;6161.353057928853;6179.598326108789;6183.505319574333;6189.257289125334;6139.3553676863285;6175.135481032748;6184.81445556634;6268.937310627018;6272.09054687077;6021.819345419644;6103.572749907464;6123.08153776937;6138.907916381348;6140.140380346845;6112;6113.23584551931;6115.938840611715;6137.232845894263;6140.8771824564155;5798.420157984167;5862.296524417097;5890.1164825276555;5944.851378715393;5983.222181116427;6033.698315084316;6097.146399503984;6114.996965385453;6137.560853825989;6139.921477736919;5963.701814909324;5964.612300200473;5975.282966044103;5983.670898100646;5983.910241346471 08:25:07 INFO - PROCESS | 1998 | |1;ext.html;441.92832381474926;472.8628697677673;512.9897402051959;527.1302351120651;551.68278240012;29720.554191687115;30670.233244168878;31355.372892542193;31499.370012599735;41225.793871030604;43205.567944320625;43789.56210437894;43804.685859424266;43819.56180438195;43845.561544384545;8396.370272229577;9593.18457931075;9804.117629413351;9806.558704858262;9808.31341806074;8569.314454843598;8780.429272097294;9631.759206019871;9763;11725.296482211052;9315.860262096074;12055.27668339898;12067.336296503689;12111.818322725167;12118.939405302961;11852.881471185265;11910.880891191064;11918.165728398928;11919.106067045006;11919.344436056057;8626.870596941051;8843.557822108869;8846.5134417607;11721.23811952229;11799.646010619696;33656.663433365844;41489.58510414887;41551.168976620604;41633.583664163576;41636.95907602304;3407.6028828180574;3532.1875968527384;3559.5728512578658;3731.869384571527;4129.938050929239;31055.37889242225;31780.20549486258;33109;33250.836220732155;33277.66722332794;3126.171564535377;3318.303156337172;3342.448495998182;3430.1596108953217;3448.7241020718284;518896;521425;521659;521731.39134304086;521843;63072.68463657652;64195.67902160459;64249.67875160594;64354.678226608565;64374.35625643683;67498;67594.66202669054;67759.64480710457;67766.98349524761;67800.32199678039;16499.17504124789;16751.246193921303;16761.161941902858;16779.580510487092;16789.16054197285;12717.173383730213;12734.108612397229;12741.490340386466;12773.744525109445;12774.23354598727;15869.52391428259;16927.915360423118;17142.142892855307;19429.34850537692;19442.805571944384;6215.12988181655;7514.624268786539;7578.317951384402;7590.292184258608;7646.985332700377;846.8518009348339;916.6929078758691;920.9815803683889;930.55798495714;967.9225661947028;30586;31068.60191291397;31211.168556401364;31273.905413310426;31855;848.9981821450624;1033.5245786937942;1075.3010543147018;1077.8868218837067;1243.2291978972914;13884.514042008683;15277.541673749805;16021.038737675777;16021.59946001336;16039;188100;192072;192361;192979;194337;60051.69974150101;60674;60679.69660151671;60728.69635651793;60780.696096519234;1363.2638375277238;1375.408574313035;1394.3795011220113;1396.888248940062;1399.4961813747043;29568.55647165251;30039.399212016073;30342.696573033987;30408.391832163674;30539.2365190872;48189.7952551189;49117;52047;52073.7396313016;52167.73916130395;454721;506407;506913.4654326705;507192;507297;20213.59572808565;22618;23584.52830943337;27243.182704518895;27636.170914872586;41166;41484.58515414807;42367.26157140091;48037.03925921532;48290.5170948286;38859.805700971316;39447.2110557793;40217.59782402255;40760.1847963045;41617.58382416258;40881;41188.1762364757;41208.969775755846;41495;42206.366904495844;39182;39635.405468917415;39717;39979.60020399875;40082.799586001885;34522.31760294435;35087.64912350844;35371.46942795911;35994.8200258997;36001.63998359983;25145.24564263075;25528.23415297544;25820.612690809277;26692;26704.732952670223 08:25:07 INFO - PROCESS | 1998 | |2;jquery.html;355.25042161040216;372.61992767377274;381.5250013732903;383.97504162229444;401.9256437559052;15520.068795872241;15988;20613.07241174147;20993.790062099375;21010.159593616238;20818.271360502386;21089.8400587968;21343.466413339673;21495.140194392206;21621.3513594592;1654.0241257657979;1671.281349019921;1672.3059930128982;1699.549619350873;5972.223610930595;5773.769049238025;6067.484263837579;6072.240969878765;6085;6096.634201947897;5071.797128114871;5767.163761254616;6019.72911218994;6028.39716028398;6031.939680603204;6048.304444988838;6053.152558641794;6068.514518838504;6072.058830881177;6076.301225359074;5253.369595648508;5255.474452554752;5258.606469285643;5260.210968354739;5606;13245.668858278525;13424.32878356088;13481.258530780804;13486.865131348659;22554.548909021727;2099.88450635215;2144.731908511436;2177.5971445282516;2291.0377641390655;2938.7061293870656;9922.851157232648;10000.04999525044;10028.849567256497;10340.276180667357;10543.84184237237;1832.3495159218419;1837.5589858434014;1846.870719049667;1874.990625046866;1888.6222755448828;90388.54805725995;93788.53105734495;111577;112414;115683;8628.43915145526;9773.902260977442;11386.316820990767;11547.40183458715;11688.88311116878;14411.351489183013;14438.205898675673;14438.278086095654;14457.638559036108;14457.638559036108;6765.627890466071;8022.237887400687;8336.291415229653;8356.247937685515;8386.077531471534;6670.83322916931;8268.586570671443;8277.58612069406;8405.663773449116;8421.19998600132;3637.3270944875285;4582.95417045832;4592.724436533752;4633.027064316531;4644.814207431665;1603.350642989591;1610.3317123393895;1865.692160793481;1908.2367053178561;1908.6946088625753;767.3592550220628;860.3590325207635;891.1667590802621;956.7560272130562;957.9185769209695;17408;21770.06628307957;23426.53146937052;23472.882635587055;23563.175288864808;889.4885440871395;908.9636414543344;912.2929729459722;932.4405356785874;974.4250891973769;9368.34421590482;11480;11486.59796907121;11486.827697584544;11510.884891151149;513378.45809296117;609147;623663;624224;625567;105726;143390;145272;146796;147660;964.064857088623;973.6981535723949;979.5591983607405;982.6658935961665;1035.502958579886;15832.445864394691;17429.82570174282;18842.246310147442;19036.904815475835;19117.90441047786;55975.720121399136;56229;57680;58130.54673633193;58246.70876645589;83543;83871.74192386997;84164.73752893589;84360.57819710863;85300;8179.386546009192;8264.049634292134;8338.416310858182;8344.779019183714;8390.82528446006;9363.719088427359;12555.43500542496;13043.869561304266;13393.062485625913;13546.79679804784;11188.216824822184;11576.421178941187;11684.766304674029;11743.647690569296;11792.823107653221;11119.777604447703;11499.102648062975;11507.597234096766;11741.823872641746;11815.586454474053;11717.589884354007;11726.824097638371;11885;11901.523939042341;11951.940240298743;7131.607761573163;7537.2462753724185;8240.546769927712;8355.749327520183;8476.745697629081;9279.257659387098;11707.126859702406;11799.35103569312;11818.054555635701;11830.408479575815 08:25:07 INFO - PROCESS | 1998 | |3;mootools.html;1341.658805384604;1452.346444100155;1468.3465857693325;1676.924538395772;1882.9905850470745;7610.54336739796;8495.405321627488;8732.650693972233;8739.912600873997;8868.556572171397;8497.32021438285;8711.607977641006;8719.215270625642;8721.040685524587;8741.956290218555;2070.7308049953485;2154.202944910385;2282.2468585366873;2330.592146374386;2364.4916342986253;2352.8941197646063;2388.1402695029774;2388.6775285336516;2391;2391.5336509380677;1997.7003449482622;2318.3045086474076;2342.7774361435636;2355.057976809273;2355.422921384263;1842.9447116586523;2058.3927741316274;2096.413004358782;2344.4021774447406;2348.626053758553;1977.604479104185;2351.318117745852;2373.988130059356;2375.845570037959;2381.1308872261675;8754.430961987451;8807.295416366675;8815.867761983576;8818.162274583905;8822.735317940473;5114.462981386938;5327.280817089682;5339.492748188916;5340.652857564246;5341.305630268079;3442.6729460701445;3518.3491054154806;3636.254567813592;3636.2909232699635;3638.599754027055;1068.9091427228695;1090.3239991205423;1094.3543309447464;1107.141964977141;1108.51225460797;11580.826287605692;11665.59170429031;11674.591389301419;11683;11693.707657308465;4288.957110428918;4313.460817397825;4537.909241815145;4774.164521208774;4808.08646357191;9810;9814.165795907427;9822.017798220264;9823;9833.606655733834;5294.602904782157;5295.993761185362;5307.230451584499;5308.654937429132;5312.495312945264;4171.478565179353;4314.848980285675;4743;4857.247126695368;4894.559489645949;3858.7105967052585;3933.8033098344968;3968.0675041365257;4013.9197216055513;4053.1893621275863;1164.6680696001768;1256.3027519726456;1257.8930790882694;1263.879931406515;1274.7131895323478;758.4084414156966;768.1190980539703;809.5264270401881;882.3382463152635;941.0683423410774;4941.530554597308;5812.941870581325;5857.736401861926;5884.499817515559;5886.8822623547285;822.3873214455269;912.8087845361733;934.6495064350869;948.3598570964709;955.0401846144719;3863.1307955710304;3917.9804100979313;3961.0493481564217;3987.720859539804;3998.3802510610903;10520.26358154937;10563.841542376871;10793.78412431747;10883.619073332395;10891.183161262938;10676.985686359783;10790.67627971162;10801.189910756724;10854.34873907568;10889.401082940356;8100.918990810134;8228.01263848342;8317;8343.332533397313;8344.123866994;5654.915176272277;5782.5952183348445;5801.709914504174;5841.591088623925;5850.853728656818;10045.899541004788;10185.745356365855;10185.796284074426;10188.745281368025;10189.337693049929;9603.615855365986;10071.69784906454;10077.143442807443;10077.596896124072;10325.380477171393;6625.4037136657935;6838;7528.247175282647;7713.845723085619;7880.133185349721;8238.423310368216;8315.542645154575;8342.957130358705;8418.326533877398;8433.915660843313;7177.605231712306;7309.342159205697;7435.144958329862;7484.288992545699;7593.240675932362;7037.859242815218;7188.317109874553;7200.279972002758;7298.781036568911;7416.925830741624;6884.380405763505;6923.89614155778;6975.3024697529845;6988.510804243654;6990.790276291719;4204.684648651302;4825.445073816556;4884.462709101925;4908.410990680998;5041.6470847040355;4992.975035124947;5001.274815151855;5023.974880125576;5035.697858128524;5124.564412024871 08:25:07 INFO - PROCESS | 1998 | |4;prototype.html;299.58806640868806;300.51616896796156;306.2252501172034;307.630842988414;311.434745936126;4217.388478670591;4934.876628084291;5313.388960269565;5484.643498172616;5544.805931792388;4936.753162341886;5446.809361672343;5479.972600137004;5489.533389661873;5493.670379777216;3394.6775056369606;3934.645881870631;3973.6225058619384;4143.233501802161;4156.023334516386;3881.8059097045175;4076.8776936691947;4119.155573107506;4136.317507611256;4140.275451795938;4087.366458198969;4116.0121570823085;4116.217918595472;4120.743173332133;4158.355454904495;3254.900589120028;3343;3875.399313106473;4033.878983630481;4117.97941010296;3262.8857989970475;3280.852361643732;3547.3682106231163;3568.660977207161;3589.730770192246;5254.238135470374;5270.4729527047375;5281.445448227958;5331.680099194022;5383.031054410205;3902.453656488094;3932.7247092703524;4399.472063352418;4728.361671174382;4744.905101897977;5260.210968354739;5472.703927416958;5558.360788509332;5592.636478628876;5644.943550564483;3295.0609076413107;3295.7692961492703;3441.63862794408;3925.7644541327613;3996.820937823349;4915.483874193194;5003.949960500421;5234.7120908350025;5631.465010823965;5948.572342637823;4014.337634290368;4039.1315867088715;4043.5754245804355;4045.3122969094734;4056.9797151014645;3408.642092580293;4019.738716983387;4102.446169767043;4158.6673066155245;4166.291730405838;4155.937660935088;4218.240716671029;4785;4786.688865223749;4790.712557246577;5650.5479561634975;5712.371639119693;5712.914306285409;5725.562688916123;5738.311402631627;1358.9932050339685;1413.5264686330195;1416.194352200952;1418.44680574576;1424.8957058279916;716.8315445870217;767.0833354141747;863.620007196844;879.4327658660128;881.3918396306528;4730.88172795676;5063.012712521023;5112.539871411516;5264.394594621591;5288.206768984683;4824.517548245218;4912.231596625212;5876.3536011039605;5913.9112913306335;5935.673537955454;4913.968066706032;4972.701637901665;5275.076861549213;5293.015119330251;5303;2446.849980509158;2542.8601426921696;2647.689393750106;2877;3021.7280444760077;5350.047232760015;5484.215891035173;5561.694106824082;5837.460704593515;6131.957567213584;5234.97382513085;5668.959174697188;6002.429769171922;6014.7594096236535;6026.9095963560585;5269.947300527022;5458.9454105458435;6038.215032045806;6049.637021778707;6068.757249709962;4454.420925279693;5875.676837773964;5895.4399332063385;5917.319508256433;5929.102687140246;5331.920021199608;5876.471117599436;5881.117832325014;5905.498032667271;5924.7037648118285;5658.85852853682;5680.77276908919;6136.7852125175405;6185.165002724754;6185.597936134137;3696.297703436446;3926.411038344271;3928.253631809947;3945.5204298388103;3959.8416063357145;5874.559408044499;5890.967616172414;5927.755171414052;5943.970280148572;6004.699765011645;5410.431904649955;5430.723779911797;5756.8987319627195;5762.164486149569;5775.566832487496;5160.767765450639;5208.635395522277;5524.502794748492;5702;5761.724118972898;4874.341963834837;4939.753012349296;5376.865578360415;5594.608377413705;5633.014222511126;4682.555157260055;4978.60171186297;5170.405403378509;5647.378788333198;5739.454751798572;4916.434610019894;5609.242752228397;5629.211910332639;5630.915536266877;5647.237622921018 08:25:07 INFO - PROCESS | 1998 | |5;yui.html;717.9712811487541;752.8870669399589;782.4718315137285;816.7014447029222;837.1252041616513;14765.704685906276;15789.131597762118;15830.920845395785;15873.206339683013;15901.1254381009;15359.07845529269;16103.677926441464;16104.11427371494;16114.516564503054;16122.274497647604;677.1265068062194;843.1484200957016;861.3367706865741;868.5700578213794;870.2254993056185;698.9475789315821;840.6595328891808;849.6219182463806;867.5792240763225;870.3211495033884;887.1350433327518;889.977750556238;890.1721399098835;891.8127193289417;893.1604291965564;706.2725392845377;885.6059053721096;886.2112719679491;886.5744442667491;888.0409158109259;647.8607099473588;650.5738741124524;652.9379708927644;667.562746401108;670.8893032649607;15218.771718424232;15222.771658425132;15275.465358712392;15281.006734562217;15286;10335.844962325496;12399.504019839196;12638.620841374774;12726.300053497054;12852.357382130856;12857.742845143044;12947.546835860794;13076.476940922352;13127.474901003949;13620.591382258548;4567.771611419415;4607.331917064065;4655.072088963585;4722.315264286659;4818.301346304801;111626.44186779096;112338.43830780794;112956;114192;115256.62690357908;11281.605143819927;11359.488823002985;11384.373859437645;11463;11566.768664626828;22443.663345049838;22457.663135052662;22511;22541.661875071888;22777.08891644349;7806.453548251568;7839.686412543549;7859.253370929752;8006.798130514155;8041.67833286662;4356.76037817923;4358.891027724332;4436.3123715824095;4509.842155524541;4530.79611417487;3418.9829050854587;3543.557055368079;3544.167120726627;3546;3554.129238336624;564.5540023381483;656.937590928861;657.523295610688;659.7756762700704;666.7066490744057;512.3314075131989;548.7859734703469;603.1676286724293;620.2618883528677;633.6166619195412;8977.775555611031;9047.68333108338;9096.586282180002;9100.726978190665;9156.221721153777;536.7826030457671;589.4400319696306;609.8505866062843;623.5821999260506;626.8432891777056;3836.9256608149763;3978.9403158952637;4236.661067114624;4306.1172459645695;4358.782060896942;143726;146986.26506867397;151546;153597.23201384145;154735;81398;94691;124466;127745;130847.34576327057;111471.44264278626;112716;113042.43478782718;113121;113700.29449558264;8347.916520834713;8549.572521374032;8618.396712230084;8819.691310804092;8852.513111778913;52844;54658.90682186255;58923.41076589351;62074.37925620686;63686.36313636804;85052.57473712592;88098.55950720461;93254;94621;96660;11470.197086203885;11493.48279327449;11515.712107197387;11521.53913843437;11720.120990925545;11426.94286528562;12019.699507512381;12200.357603558119;12244.326562038817;12490.562830300896;9958.900410995797;11765.647030589096;11767.117466189899;11828.585999489977;12086.972607328476;11357.97778199966;11439.942800285946;11573.132015098732;11908.404579770804;11924.523019079139;11447.942760286145;11538.711532211762;11948.761024779282;12011.978981786646;12078.818817717565;9564.218593736043;9864.16154626836;10107.595696172071;10281.228907832092;10287.125594324267;8810.89863767029;9269.490178040272;9432.339736218399;9933.751656208364;10075.647352342632 08:25:07 INFO - PROCESS | 1998 | __end_tp_report 08:25:07 INFO - PROCESS | 1998 | __start_cc_report 08:25:07 INFO - PROCESS | 1998 | _x_x_mozilla_cycle_collect,1133 08:25:07 INFO - PROCESS | 1998 | __end_cc_report 08:25:07 INFO - PROCESS | 1998 | __startTimestamp1467300307945__endTimestamp 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | ------- Summary: start ------- 08:25:07 INFO - PROCESS | 1998 | Number of tests: 6 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | [#0] dojo.html Cycles:165 Average:5757.35 Median:5975.28 stddev:621.93 (10.4%) stddev-sans-first:593.44 08:25:07 INFO - PROCESS | 1998 | Values: 3308.9 3321.5 3341.5 3350.2 3381.8 5633.4 5647.9 5691.4 5712.7 5737.4 5645.9 5723.5 5728.4 5731.2 5733.1 5171.6 5232.7 5266.3 5267.7 5336.2 5217.7 5249.6 5277.4 5315.0 5316.2 5232.3 5254.9 5292.9 5297.5 5315.9 5339.5 5340.6 5340.7 5358.2 5372.8 5096.7 5122.5 5165.5 5276.6 5285.7 5668.6 5694.8 5716.5 5737.8 5747.8 6218.3 6245.4 6253.2 6259.5 6265.9 6118.7 6160.3 6233.3 6237.0 6240.5 5813.3 5819.2 5828.7 5831.4 5837.2 6255.5 6274.2 6277.9 6279.1 6285.7 5946.7 5997.2 6085.1 6109.6 6144.4 6293.1 6304.1 6304.6 6315.1 6323.0 6139.9 6229.5 6231.8 6246.5 6262.5 6114.1 6135.0 6146.8 6195.9 6250.1 4941.7 4977.6 4980.2 4988.9 4994.5 4430.9 4463.9 4466.2 4520.0 4584.5 5724.1 5728.9 5739.4 5752.1 5797.7 6107.4 6253.6 6312.5 6325.1 6340.9 5611.5 5625.4 5668.8 5696.1 5709.3 5421.3 5432.5 5437.0 5448.5 5471.9 6218.5 6271.5 6287.8 6291.6 6307.3 6113.1 6158.3 6167.4 6217.2 6266.2 6209.6 6253.1 6254.2 6269.6 6286.1 6159.0 6161.4 6179.6 6183.5 6189.3 6139.4 6175.1 6184.8 6268.9 6272.1 6021.8 6103.6 6123.1 6138.9 6140.1 6112.0 6113.2 6115.9 6137.2 6140.9 5798.4 5862.3 5890.1 5944.9 5983.2 6033.7 6097.1 6115.0 6137.6 6139.9 5963.7 5964.6 5975.3 5983.7 5983.9 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | [#1] ext.html Cycles:180 Average:56880.68 Median:39020.90 stddev:114875.43 (294.4%) stddev-sans-first:115119.53 08:25:07 INFO - PROCESS | 1998 | Values: 441.9 472.9 513.0 527.1 551.7 29720.6 30670.2 31355.4 31499.4 41225.8 43205.6 43789.6 43804.7 43819.6 43845.6 8396.4 9593.2 9804.1 9806.6 9808.3 8569.3 8780.4 9631.8 9763.0 11725.3 9315.9 12055.3 12067.3 12111.8 12118.9 11852.9 11910.9 11918.2 11919.1 11919.3 8626.9 8843.6 8846.5 11721.2 11799.6 33656.7 41489.6 41551.2 41633.6 41637.0 3407.6 3532.2 3559.6 3731.9 4129.9 31055.4 31780.2 33109.0 33250.8 33277.7 3126.2 3318.3 3342.4 3430.2 3448.7 518896.0 521425.0 521659.0 521731.4 521843.0 63072.7 64195.7 64249.7 64354.7 64374.4 67498.0 67594.7 67759.6 67767.0 67800.3 16499.2 16751.2 16761.2 16779.6 16789.2 12717.2 12734.1 12741.5 12773.7 12774.2 15869.5 16927.9 17142.1 19429.3 19442.8 6215.1 7514.6 7578.3 7590.3 7647.0 846.9 916.7 921.0 930.6 967.9 30586.0 31068.6 31211.2 31273.9 31855.0 849.0 1033.5 1075.3 1077.9 1243.2 13884.5 15277.5 16021.0 16021.6 16039.0 188100.0 192072.0 192361.0 192979.0 194337.0 60051.7 60674.0 60679.7 60728.7 60780.7 1363.3 1375.4 1394.4 1396.9 1399.5 29568.6 30039.4 30342.7 30408.4 30539.2 48189.8 49117.0 52047.0 52073.7 52167.7 454721.0 506407.0 506913.5 507192.0 507297.0 20213.6 22618.0 23584.5 27243.2 27636.2 41166.0 41484.6 42367.3 48037.0 48290.5 38859.8 39447.2 40217.6 40760.2 41617.6 40881.0 41188.2 41209.0 41495.0 42206.4 39182.0 39635.4 39717.0 39979.6 40082.8 34522.3 35087.6 35371.5 35994.8 36001.6 25145.2 25528.2 25820.6 26692.0 26704.7 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | [#2] jquery.html Cycles:180 Average:34860.86 Median:13250.94 stddev:100476.39 (758.3%) stddev-sans-first:100724.85 08:25:07 INFO - PROCESS | 1998 | Values: 355.3 372.6 381.5 384.0 401.9 15520.1 15988.0 20613.1 20993.8 21010.2 20818.3 21089.8 21343.5 21495.1 21621.4 1654.0 1671.3 1672.3 1699.5 5972.2 5773.8 6067.5 6072.2 6085.0 6096.6 5071.8 5767.2 6019.7 6028.4 6031.9 6048.3 6053.2 6068.5 6072.1 6076.3 5253.4 5255.5 5258.6 5260.2 5606.0 13245.7 13424.3 13481.3 13486.9 22554.5 2099.9 2144.7 2177.6 2291.0 2938.7 9922.9 10000.0 10028.8 10340.3 10543.8 1832.3 1837.6 1846.9 1875.0 1888.6 90388.5 93788.5 111577.0 112414.0 115683.0 8628.4 9773.9 11386.3 11547.4 11688.9 14411.4 14438.2 14438.3 14457.6 14457.6 6765.6 8022.2 8336.3 8356.2 8386.1 6670.8 8268.6 8277.6 8405.7 8421.2 3637.3 4583.0 4592.7 4633.0 4644.8 1603.4 1610.3 1865.7 1908.2 1908.7 767.4 860.4 891.2 956.8 957.9 17408.0 21770.1 23426.5 23472.9 23563.2 889.5 909.0 912.3 932.4 974.4 9368.3 11480.0 11486.6 11486.8 11510.9 513378.5 609147.0 623663.0 624224.0 625567.0 105726.0 143390.0 145272.0 146796.0 147660.0 964.1 973.7 979.6 982.7 1035.5 15832.4 17429.8 18842.2 19036.9 19117.9 55975.7 56229.0 57680.0 58130.5 58246.7 83543.0 83871.7 84164.7 84360.6 85300.0 8179.4 8264.0 8338.4 8344.8 8390.8 9363.7 12555.4 13043.9 13393.1 13546.8 11188.2 11576.4 11684.8 11743.6 11792.8 11119.8 11499.1 11507.6 11741.8 11815.6 11717.6 11726.8 11885.0 11901.5 11951.9 7131.6 7537.2 8240.5 8355.7 8476.7 9279.3 11707.1 11799.4 11818.1 11830.4 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | [#3] mootools.html Cycles:180 Average:5671.08 Median:4889.51 stddev:3221.19 (65.9%) stddev-sans-first:3213.79 08:25:07 INFO - PROCESS | 1998 | Values: 1341.7 1452.3 1468.3 1676.9 1883.0 7610.5 8495.4 8732.7 8739.9 8868.6 8497.3 8711.6 8719.2 8721.0 8742.0 2070.7 2154.2 2282.2 2330.6 2364.5 2352.9 2388.1 2388.7 2391.0 2391.5 1997.7 2318.3 2342.8 2355.1 2355.4 1842.9 2058.4 2096.4 2344.4 2348.6 1977.6 2351.3 2374.0 2375.8 2381.1 8754.4 8807.3 8815.9 8818.2 8822.7 5114.5 5327.3 5339.5 5340.7 5341.3 3442.7 3518.3 3636.3 3636.3 3638.6 1068.9 1090.3 1094.4 1107.1 1108.5 11580.8 11665.6 11674.6 11683.0 11693.7 4289.0 4313.5 4537.9 4774.2 4808.1 9810.0 9814.2 9822.0 9823.0 9833.6 5294.6 5296.0 5307.2 5308.7 5312.5 4171.5 4314.8 4743.0 4857.2 4894.6 3858.7 3933.8 3968.1 4013.9 4053.2 1164.7 1256.3 1257.9 1263.9 1274.7 758.4 768.1 809.5 882.3 941.1 4941.5 5812.9 5857.7 5884.5 5886.9 822.4 912.8 934.6 948.4 955.0 3863.1 3918.0 3961.0 3987.7 3998.4 10520.3 10563.8 10793.8 10883.6 10891.2 10677.0 10790.7 10801.2 10854.3 10889.4 8100.9 8228.0 8317.0 8343.3 8344.1 5654.9 5782.6 5801.7 5841.6 5850.9 10045.9 10185.7 10185.8 10188.7 10189.3 9603.6 10071.7 10077.1 10077.6 10325.4 6625.4 6838.0 7528.2 7713.8 7880.1 8238.4 8315.5 8343.0 8418.3 8433.9 7177.6 7309.3 7435.1 7484.3 7593.2 7037.9 7188.3 7200.3 7298.8 7416.9 6884.4 6923.9 6975.3 6988.5 6990.8 4204.7 4825.4 4884.5 4908.4 5041.6 4993.0 5001.3 5024.0 5035.7 5124.6 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | [#4] prototype.html Cycles:180 Average:4572.95 Median:5221.67 stddev:1430.77 (27.4%) stddev-sans-first:1398.37 08:25:07 INFO - PROCESS | 1998 | Values: 299.6 300.5 306.2 307.6 311.4 4217.4 4934.9 5313.4 5484.6 5544.8 4936.8 5446.8 5480.0 5489.5 5493.7 3394.7 3934.6 3973.6 4143.2 4156.0 3881.8 4076.9 4119.2 4136.3 4140.3 4087.4 4116.0 4116.2 4120.7 4158.4 3254.9 3343.0 3875.4 4033.9 4118.0 3262.9 3280.9 3547.4 3568.7 3589.7 5254.2 5270.5 5281.4 5331.7 5383.0 3902.5 3932.7 4399.5 4728.4 4744.9 5260.2 5472.7 5558.4 5592.6 5644.9 3295.1 3295.8 3441.6 3925.8 3996.8 4915.5 5003.9 5234.7 5631.5 5948.6 4014.3 4039.1 4043.6 4045.3 4057.0 3408.6 4019.7 4102.4 4158.7 4166.3 4155.9 4218.2 4785.0 4786.7 4790.7 5650.5 5712.4 5712.9 5725.6 5738.3 1359.0 1413.5 1416.2 1418.4 1424.9 716.8 767.1 863.6 879.4 881.4 4730.9 5063.0 5112.5 5264.4 5288.2 4824.5 4912.2 5876.4 5913.9 5935.7 4914.0 4972.7 5275.1 5293.0 5303.0 2446.8 2542.9 2647.7 2877.0 3021.7 5350.0 5484.2 5561.7 5837.5 6132.0 5235.0 5669.0 6002.4 6014.8 6026.9 5269.9 5458.9 6038.2 6049.6 6068.8 4454.4 5875.7 5895.4 5917.3 5929.1 5331.9 5876.5 5881.1 5905.5 5924.7 5658.9 5680.8 6136.8 6185.2 6185.6 3696.3 3926.4 3928.3 3945.5 3959.8 5874.6 5891.0 5927.8 5944.0 6004.7 5410.4 5430.7 5756.9 5762.2 5775.6 5160.8 5208.6 5524.5 5702.0 5761.7 4874.3 4939.8 5376.9 5594.6 5633.0 4682.6 4978.6 5170.4 5647.4 5739.5 4916.4 5609.2 5629.2 5630.9 5647.2 08:25:07 INFO - PROCESS | 1998 | 08:25:07 INFO - PROCESS | 1998 | [#5] yui.html Cycles:180 Average:24201.57 Median:4357.77 stddev:39062.66 (896.4%) stddev-sans-first:39132.44 08:25:07 INFO - PROCESS | 1998 | Values: 718.0 752.9 782.5 816.7 837.1 14765.7 15789.1 15830.9 15873.2 15901.1 15359.1 16103.7 16104.1 16114.5 16122.3 677.1 843.1 861.3 868.6 870.2 698.9 840.7 849.6 867.6 870.3 887.1 890.0 890.2 891.8 893.2 706.3 885.6 886.2 886.6 888.0 647.9 650.6 652.9 667.6 670.9 15218.8 15222.8 15275.5 15281.0 15286.0 10335.8 12399.5 12638.6 12726.3 12852.4 12857.7 12947.5 13076.5 13127.5 13620.6 4567.8 4607.3 4655.1 4722.3 4818.3 111626.4 112338.4 112956.0 114192.0 115256.6 11281.6 11359.5 11384.4 11463.0 11566.8 22443.7 22457.7 22511.0 22541.7 22777.1 7806.5 7839.7 7859.3 8006.8 8041.7 4356.8 4358.9 4436.3 4509.8 4530.8 3419.0 3543.6 3544.2 3546.0 3554.1 564.6 656.9 657.5 659.8 666.7 512.3 548.8 603.2 620.3 633.6 8977.8 9047.7 9096.6 9100.7 9156.2 536.8 589.4 609.9 623.6 626.8 3836.9 3978.9 4236.7 4306.1 4358.8 143726.0 146986.3 151546.0 153597.2 154735.0 81398.0 94691.0 124466.0 127745.0 130847.3 111471.4 112716.0 113042.4 113121.0 113700.3 8347.9 8549.6 8618.4 8819.7 8852.5 52844.0 54658.9 58923.4 62074.4 63686.4 85052.6 88098.6 93254.0 94621.0 96660.0 11470.2 11493.5 11515.7 11521.5 11720.1 11426.9 12019.7 12200.4 12244.3 12490.6 9958.9 11765.6 11767.1 11828.6 12087.0 11358.0 11439.9 11573.1 11908.4 11924.5 11447.9 11538.7 11948.8 12012.0 12078.8 9564.2 9864.2 10107.6 10281.2 10287.1 8810.9 9269.5 9432.3 9933.8 10075.6 08:25:07 INFO - PROCESS | 1998 | -------- Summary: end -------- 08:25:07 INFO - PROCESS | 1998 | 08:25:08 INFO - TEST-INFO | 1998: exit 0 08:25:08 INFO - TEST-OK | dromaeo_css | took 1116881ms 08:25:08 INFO - TEST-START | kraken 08:25:08 INFO - operating with platform_type : mac_ 08:25:08 INFO - Initialising browser for kraken test... 08:25:08 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpvFxrO5/profile http://localhost:49384/getInfo.html) 08:25:10 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 08:25:10 INFO - PROCESS | 2001 | colorDepth:24 08:25:10 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 08:25:10 INFO - PROCESS | 2001 | __metrics 08:25:11 INFO - PROCESS | 2001 | 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" 08:25:11 INFO - PROCESS | 2001 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:11 INFO - TEST-INFO | 2001: exit 0 08:25:11 INFO - Browser initialized. 08:25:11 INFO - Running cycle 1/1 for kraken test... 08:25:11 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpvFxrO5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:23 INFO - PROCESS | 2002 | RSS: Main: 243666944 08:25:23 INFO - PROCESS | 2002 | 08:25:26 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:27 INFO - PROCESS | 2002 | RSS: Main: 294461440 08:25:27 INFO - PROCESS | 2002 | 08:25:29 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-dft) 08:25:30 INFO - PROCESS | 2002 | RSS: Main: 304619520 08:25:30 INFO - PROCESS | 2002 | 08:25:34 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-fft) 08:25:34 INFO - PROCESS | 2002 | RSS: Main: 390656000 08:25:34 INFO - PROCESS | 2002 | 08:25:36 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-oscillator) 08:25:37 INFO - PROCESS | 2002 | RSS: Main: 291483648 08:25:37 INFO - PROCESS | 2002 | 08:25:39 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:40 INFO - PROCESS | 2002 | RSS: Main: 295682048 08:25:40 INFO - PROCESS | 2002 | 08:25:42 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49384/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:43 INFO - PROCESS | 2002 | RSS: Main: 333479936 08:25:43 INFO - PROCESS | 2002 | 08:25:46 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49384/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:47 INFO - PROCESS | 2002 | RSS: Main: 333148160 08:25:47 INFO - PROCESS | 2002 | 08:25:49 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49384/tests/kraken/driver.html?testName=json-parse-financial) 08:25:50 INFO - PROCESS | 2002 | RSS: Main: 331796480 08:25:50 INFO - PROCESS | 2002 | 08:25:51 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:52 INFO - PROCESS | 2002 | RSS: Main: 312082432 08:25:52 INFO - PROCESS | 2002 | 08:25:54 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:55 INFO - PROCESS | 2002 | RSS: Main: 318300160 08:25:55 INFO - PROCESS | 2002 | 08:25:57 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:58 INFO - PROCESS | 2002 | RSS: Main: 316223488 08:25:58 INFO - PROCESS | 2002 | 08:26:00 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:01 INFO - PROCESS | 2002 | RSS: Main: 325042176 08:26:01 INFO - PROCESS | 2002 | 08:26:04 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:05 INFO - PROCESS | 2002 | RSS: Main: 327667712 08:26:05 INFO - PROCESS | 2002 | 08:26:06 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49384/tests/kraken/driver.html?testName=ai-astar) 08:26:07 INFO - PROCESS | 2002 | RSS: Main: 370978816 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | __start_tp_report 08:26:07 INFO - PROCESS | 2002 | _x_x_mozilla_page_load 08:26:07 INFO - PROCESS | 2002 | _x_x_mozilla_page_load_details 08:26:07 INFO - PROCESS | 2002 | |i|pagename|runs| 08:26:07 INFO - PROCESS | 2002 | |0;ai-astar;100;112;112;112;112;112;114;111;111;111 08:26:07 INFO - PROCESS | 2002 | |1;audio-beat-detection;144;109;107;159;107;106;127;106;142;110 08:26:07 INFO - PROCESS | 2002 | |2;audio-dft;184;186;184;184;186;186;183;183;185;183 08:26:07 INFO - PROCESS | 2002 | |3;audio-fft;81;79;52;88;59;59;67;61;85;58 08:26:07 INFO - PROCESS | 2002 | |4;audio-oscillator;84;127;101;71;75;71;96;76;85;136 08:26:07 INFO - PROCESS | 2002 | |5;imaging-gaussian-blur;89;86;90;87;89;86;90;88;89;85 08:26:07 INFO - PROCESS | 2002 | |6;imaging-darkroom;96;95;96;95;95;96;96;96;95;94 08:26:07 INFO - PROCESS | 2002 | |7;imaging-desaturate;85;85;86;84;86;85;85;88;86;86 08:26:07 INFO - PROCESS | 2002 | |8;json-parse-financial;56;54;54;54;54;55;53;55;53;53 08:26:07 INFO - PROCESS | 2002 | |9;json-stringify-tinderbox;69;71;68;78;71;71;71;72;72;74 08:26:07 INFO - PROCESS | 2002 | |10;stanford-crypto-aes;82;83;83;88;83;97;75;82;82;70 08:26:07 INFO - PROCESS | 2002 | |11;stanford-crypto-ccm;139;144;122;143;121;145;151;146;219;138 08:26:07 INFO - PROCESS | 2002 | |12;stanford-crypto-pbkdf2;161;161;163;158;214;175;163;160;162;162 08:26:07 INFO - PROCESS | 2002 | |13;stanford-crypto-sha256-iterative;66;67;66;66;66;64;65;66;66;66 08:26:07 INFO - PROCESS | 2002 | __end_tp_report 08:26:07 INFO - PROCESS | 2002 | __start_cc_report 08:26:07 INFO - PROCESS | 2002 | _x_x_mozilla_cycle_collect,2070 08:26:07 INFO - PROCESS | 2002 | __end_cc_report 08:26:07 INFO - PROCESS | 2002 | __startTimestamp1467300367024__endTimestamp 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | ------- Summary: start ------- 08:26:07 INFO - PROCESS | 2002 | Number of tests: 14 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.86 (3.4%) stddev-sans-first:0.93 08:26:07 INFO - PROCESS | 2002 | Values: 100.0 112.0 112.0 112.0 112.0 112.0 114.0 111.0 111.0 111.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:118.50 stddev:19.87 (16.8%) stddev-sans-first:19.36 08:26:07 INFO - PROCESS | 2002 | Values: 144.0 109.0 107.0 159.0 107.0 106.0 127.0 106.0 142.0 110.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:1.26 (0.7%) stddev-sans-first:1.33 08:26:07 INFO - PROCESS | 2002 | Values: 184.0 186.0 184.0 184.0 186.0 186.0 183.0 183.0 185.0 183.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#3] audio-fft Cycles:10 Average:68.90 Median:73.00 stddev:13.08 (17.9%) stddev-sans-first:13.12 08:26:07 INFO - PROCESS | 2002 | Values: 81.0 79.0 52.0 88.0 59.0 59.0 67.0 61.0 85.0 58.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:75.50 stddev:23.09 (30.6%) stddev-sans-first:24.30 08:26:07 INFO - PROCESS | 2002 | Values: 84.0 127.0 101.0 71.0 75.0 71.0 96.0 76.0 85.0 136.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:89.00 stddev:1.79 (2.0%) stddev-sans-first:1.86 08:26:07 INFO - PROCESS | 2002 | Values: 89.0 86.0 90.0 87.0 89.0 86.0 90.0 88.0 89.0 85.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 08:26:07 INFO - PROCESS | 2002 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 94.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.07 (1.2%) stddev-sans-first:1.12 08:26:07 INFO - PROCESS | 2002 | Values: 85.0 85.0 86.0 84.0 86.0 85.0 85.0 88.0 86.0 86.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:0.78 08:26:07 INFO - PROCESS | 2002 | Values: 56.0 54.0 54.0 54.0 54.0 55.0 53.0 55.0 53.0 53.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:2.75 (3.8%) stddev-sans-first:2.74 08:26:07 INFO - PROCESS | 2002 | Values: 69.0 71.0 68.0 78.0 71.0 71.0 71.0 72.0 72.0 74.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:7.11 (8.6%) stddev-sans-first:7.54 08:26:07 INFO - PROCESS | 2002 | Values: 82.0 83.0 83.0 88.0 83.0 97.0 75.0 82.0 82.0 70.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:144.50 stddev:27.23 (18.8%) stddev-sans-first:28.74 08:26:07 INFO - PROCESS | 2002 | Values: 139.0 144.0 122.0 143.0 121.0 145.0 151.0 146.0 219.0 138.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:162.50 stddev:16.83 (10.4%) stddev-sans-first:17.66 08:26:07 INFO - PROCESS | 2002 | Values: 161.0 161.0 163.0 158.0 214.0 175.0 163.0 160.0 162.0 162.0 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - PROCESS | 2002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 08:26:07 INFO - PROCESS | 2002 | Values: 66.0 67.0 66.0 66.0 66.0 64.0 65.0 66.0 66.0 66.0 08:26:07 INFO - PROCESS | 2002 | -------- Summary: end -------- 08:26:07 INFO - PROCESS | 2002 | 08:26:07 INFO - TEST-INFO | 2002: exit 0 08:26:07 INFO - TEST-OK | kraken | took 59294ms 08:26:07 INFO - SUITE-END | took 1176s 08:26:08 INFO - Completed test suite (00:19:36) 08:26:08 INFO - javascript benchmark 08:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.9172770680734, 3321.518379834924, 3341.4820702791067, 3350.2127000154974, 3381.8309084545767, 5633.40849210832, 5647.887042259153, 5691.430856914307, 5712.71436428179, 5737.368889422165, 5645.943540564593, 5723.456271654186, 5728.42715728427, 5731.197632331467, 5733.082706766918, 5171.5862730981435, 5232.686038837663, 5266.289050978107, 5267.683938963655, 5336.17289320156, 5217.660852044605, 5249.632525723201, 5277.445868183843, 5314.973425132869, 5316.175992721134, 5232.3197984262, 5254.894902101955, 5292.947070529303, 5297.523222909937, 5315.946840531584, 5339.492748188916, 5340.572754179656, 5340.732963351837, 5358.2498450217, 5372.811951581676, 5096.694198348111, 5122.462141475129, 5165.509276618715, 5276.604254680914, 5285.709285989269, 5668.603197776158, 5694.77220911163, 5716.485516303553, 5737.77048918047, 5747.798827041075, 6218.284897236786, 6245.375462453764, 6253.218347706536, 6259.530535209878, 6265.8746825063245, 6118.694065296718, 6160.260768707739, 6233.345498722614, 6237.0, 6240.500759939239, 5813.302403711497, 5819.185314056035, 5828.679422631796, 5831.3877042910735, 5837.153612726131, 6255.499560035186, 6274.247090349188, 6277.874442511215, 6279.058141278753, 6285.654289014056, 5946.70266486674, 5997.220361352996, 6085.056816193497, 6109.625334299747, 6144.41628045335, 6293.056041593798, 6304.05439184126, 6304.590201636879, 6315.052742088724, 6322.956712142537, 6139.938600613937, 6229.501639868799, 6231.844203894939, 6246.531510136667, 6262.499000079983, 6114.144019837227, 6135.01831721223, 6146.784862529879, 6195.876082478325, 6250.093736408196, 4941.654084214142, 4977.601791856643, 4980.228064649985, 4988.8752781180765, 4994.500549945049, 4430.911381772346, 4463.933041004388, 4466.218411777926, 4520.0, 4584.541545845455, 5724.055530837365, 5728.885422291531, 5739.397363276879, 5752.13717942312, 5797.652140871562, 6107.370879189147, 6253.5622506425025, 6312.463440607508, 6325.05124231369, 6340.873182536324, 5611.5230205433, 5625.409332020161, 5668.773249070074, 5696.088625819849, 5709.286339207599, 5421.322334708161, 5432.456754324536, 5436.972815135899, 5448.482394172547, 5471.863203419946, 6218.502519798496, 6271.529635277281, 6287.842803929847, 6291.622502649764, 6307.306196318493, 6113.050656958906, 6158.3225845157895, 6167.414095660905, 6217.222847144107, 6266.185395898504, 6209.627422354673, 6253.093301471352, 6254.186955695731, 6269.5611307208055, 6286.119943207863, 6159.0, 6161.353057928853, 6179.598326108789, 6183.505319574333, 6189.257289125334, 6139.3553676863285, 6175.135481032748, 6184.81445556634, 6268.937310627018, 6272.09054687077, 6021.819345419644, 6103.572749907464, 6123.08153776937, 6138.907916381348, 6140.140380346845, 6112.0, 6113.23584551931, 6115.938840611715, 6137.232845894263, 6140.8771824564155, 5798.420157984167, 5862.296524417097, 5890.1164825276555, 5944.851378715393, 5983.222181116427, 6033.698315084316, 6097.146399503984, 6114.996965385453, 6137.560853825989, 6139.921477736919, 5963.701814909324, 5964.612300200473, 5975.282966044103, 5983.670898100646, 5983.910241346471], "value": 5717.224107809573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.92832381474926, 472.8628697677673, 512.9897402051959, 527.1302351120651, 551.68278240012, 29720.554191687115, 30670.233244168878, 31355.372892542193, 31499.370012599735, 41225.793871030604, 43205.567944320625, 43789.56210437894, 43804.685859424266, 43819.56180438195, 43845.561544384545, 8396.370272229577, 9593.18457931075, 9804.117629413351, 9806.558704858262, 9808.31341806074, 8569.314454843598, 8780.429272097294, 9631.759206019871, 9763.0, 11725.296482211052, 9315.860262096074, 12055.27668339898, 12067.336296503689, 12111.818322725167, 12118.939405302961, 11852.881471185265, 11910.880891191064, 11918.165728398928, 11919.106067045006, 11919.344436056057, 8626.870596941051, 8843.557822108869, 8846.5134417607, 11721.23811952229, 11799.646010619696, 33656.663433365844, 41489.58510414887, 41551.168976620604, 41633.583664163576, 41636.95907602304, 3407.6028828180574, 3532.1875968527384, 3559.5728512578658, 3731.869384571527, 4129.938050929239, 31055.37889242225, 31780.20549486258, 33109.0, 33250.836220732155, 33277.66722332794, 3126.171564535377, 3318.303156337172, 3342.448495998182, 3430.1596108953217, 3448.7241020718284, 518896.0, 521425.0, 521659.0, 521731.39134304086, 521843.0, 63072.68463657652, 64195.67902160459, 64249.67875160594, 64354.678226608565, 64374.35625643683, 67498.0, 67594.66202669054, 67759.64480710457, 67766.98349524761, 67800.32199678039, 16499.17504124789, 16751.246193921303, 16761.161941902858, 16779.580510487092, 16789.16054197285, 12717.173383730213, 12734.108612397229, 12741.490340386466, 12773.744525109445, 12774.23354598727, 15869.52391428259, 16927.915360423118, 17142.142892855307, 19429.34850537692, 19442.805571944384, 6215.12988181655, 7514.624268786539, 7578.317951384402, 7590.292184258608, 7646.985332700377, 846.8518009348339, 916.6929078758691, 920.9815803683889, 930.55798495714, 967.9225661947028, 30586.0, 31068.60191291397, 31211.168556401364, 31273.905413310426, 31855.0, 848.9981821450624, 1033.5245786937942, 1075.3010543147018, 1077.8868218837067, 1243.2291978972914, 13884.514042008683, 15277.541673749805, 16021.038737675777, 16021.59946001336, 16039.0, 188100.0, 192072.0, 192361.0, 192979.0, 194337.0, 60051.69974150101, 60674.0, 60679.69660151671, 60728.69635651793, 60780.696096519234, 1363.2638375277238, 1375.408574313035, 1394.3795011220113, 1396.888248940062, 1399.4961813747043, 29568.55647165251, 30039.399212016073, 30342.696573033987, 30408.391832163674, 30539.2365190872, 48189.7952551189, 49117.0, 52047.0, 52073.7396313016, 52167.73916130395, 454721.0, 506407.0, 506913.4654326705, 507192.0, 507297.0, 20213.59572808565, 22618.0, 23584.52830943337, 27243.182704518895, 27636.170914872586, 41166.0, 41484.58515414807, 42367.26157140091, 48037.03925921532, 48290.5170948286, 38859.805700971316, 39447.2110557793, 40217.59782402255, 40760.1847963045, 41617.58382416258, 40881.0, 41188.1762364757, 41208.969775755846, 41495.0, 42206.366904495844, 39182.0, 39635.405468917415, 39717.0, 39979.60020399875, 40082.799586001885, 34522.31760294435, 35087.64912350844, 35371.46942795911, 35994.8200258997, 36001.63998359983, 25145.24564263075, 25528.23415297544, 25820.612690809277, 26692.0, 26704.732952670223], "value": 19608.837870172218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.25042161040216, 372.61992767377274, 381.5250013732903, 383.97504162229444, 401.9256437559052, 15520.068795872241, 15988.0, 20613.07241174147, 20993.790062099375, 21010.159593616238, 20818.271360502386, 21089.8400587968, 21343.466413339673, 21495.140194392206, 21621.3513594592, 1654.0241257657979, 1671.281349019921, 1672.3059930128982, 1699.549619350873, 5972.223610930595, 5773.769049238025, 6067.484263837579, 6072.240969878765, 6085.0, 6096.634201947897, 5071.797128114871, 5767.163761254616, 6019.72911218994, 6028.39716028398, 6031.939680603204, 6048.304444988838, 6053.152558641794, 6068.514518838504, 6072.058830881177, 6076.301225359074, 5253.369595648508, 5255.474452554752, 5258.606469285643, 5260.210968354739, 5606.0, 13245.668858278525, 13424.32878356088, 13481.258530780804, 13486.865131348659, 22554.548909021727, 2099.88450635215, 2144.731908511436, 2177.5971445282516, 2291.0377641390655, 2938.7061293870656, 9922.851157232648, 10000.04999525044, 10028.849567256497, 10340.276180667357, 10543.84184237237, 1832.3495159218419, 1837.5589858434014, 1846.870719049667, 1874.990625046866, 1888.6222755448828, 90388.54805725995, 93788.53105734495, 111577.0, 112414.0, 115683.0, 8628.43915145526, 9773.902260977442, 11386.316820990767, 11547.40183458715, 11688.88311116878, 14411.351489183013, 14438.205898675673, 14438.278086095654, 14457.638559036108, 14457.638559036108, 6765.627890466071, 8022.237887400687, 8336.291415229653, 8356.247937685515, 8386.077531471534, 6670.83322916931, 8268.586570671443, 8277.58612069406, 8405.663773449116, 8421.19998600132, 3637.3270944875285, 4582.95417045832, 4592.724436533752, 4633.027064316531, 4644.814207431665, 1603.350642989591, 1610.3317123393895, 1865.692160793481, 1908.2367053178561, 1908.6946088625753, 767.3592550220628, 860.3590325207635, 891.1667590802621, 956.7560272130562, 957.9185769209695, 17408.0, 21770.06628307957, 23426.53146937052, 23472.882635587055, 23563.175288864808, 889.4885440871395, 908.9636414543344, 912.2929729459722, 932.4405356785874, 974.4250891973769, 9368.34421590482, 11480.0, 11486.59796907121, 11486.827697584544, 11510.884891151149, 513378.45809296117, 609147.0, 623663.0, 624224.0, 625567.0, 105726.0, 143390.0, 145272.0, 146796.0, 147660.0, 964.064857088623, 973.6981535723949, 979.5591983607405, 982.6658935961665, 1035.502958579886, 15832.445864394691, 17429.82570174282, 18842.246310147442, 19036.904815475835, 19117.90441047786, 55975.720121399136, 56229.0, 57680.0, 58130.54673633193, 58246.70876645589, 83543.0, 83871.74192386997, 84164.73752893589, 84360.57819710863, 85300.0, 8179.386546009192, 8264.049634292134, 8338.416310858182, 8344.779019183714, 8390.82528446006, 9363.719088427359, 12555.43500542496, 13043.869561304266, 13393.062485625913, 13546.79679804784, 11188.216824822184, 11576.421178941187, 11684.766304674029, 11743.647690569296, 11792.823107653221, 11119.777604447703, 11499.102648062975, 11507.597234096766, 11741.823872641746, 11815.586454474053, 11717.589884354007, 11726.824097638371, 11885.0, 11901.523939042341, 11951.940240298743, 7131.607761573163, 7537.2462753724185, 8240.546769927712, 8355.749327520183, 8476.745697629081, 9279.257659387098, 11707.126859702406, 11799.35103569312, 11818.054555635701, 11830.408479575815], "value": 9193.125859149262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.658805384604, 1452.346444100155, 1468.3465857693325, 1676.924538395772, 1882.9905850470745, 7610.54336739796, 8495.405321627488, 8732.650693972233, 8739.912600873997, 8868.556572171397, 8497.32021438285, 8711.607977641006, 8719.215270625642, 8721.040685524587, 8741.956290218555, 2070.7308049953485, 2154.202944910385, 2282.2468585366873, 2330.592146374386, 2364.4916342986253, 2352.8941197646063, 2388.1402695029774, 2388.6775285336516, 2391.0, 2391.5336509380677, 1997.7003449482622, 2318.3045086474076, 2342.7774361435636, 2355.057976809273, 2355.422921384263, 1842.9447116586523, 2058.3927741316274, 2096.413004358782, 2344.4021774447406, 2348.626053758553, 1977.604479104185, 2351.318117745852, 2373.988130059356, 2375.845570037959, 2381.1308872261675, 8754.430961987451, 8807.295416366675, 8815.867761983576, 8818.162274583905, 8822.735317940473, 5114.462981386938, 5327.280817089682, 5339.492748188916, 5340.652857564246, 5341.305630268079, 3442.6729460701445, 3518.3491054154806, 3636.254567813592, 3636.2909232699635, 3638.599754027055, 1068.9091427228695, 1090.3239991205423, 1094.3543309447464, 1107.141964977141, 1108.51225460797, 11580.826287605692, 11665.59170429031, 11674.591389301419, 11683.0, 11693.707657308465, 4288.957110428918, 4313.460817397825, 4537.909241815145, 4774.164521208774, 4808.08646357191, 9810.0, 9814.165795907427, 9822.017798220264, 9823.0, 9833.606655733834, 5294.602904782157, 5295.993761185362, 5307.230451584499, 5308.654937429132, 5312.495312945264, 4171.478565179353, 4314.848980285675, 4743.0, 4857.247126695368, 4894.559489645949, 3858.7105967052585, 3933.8033098344968, 3968.0675041365257, 4013.9197216055513, 4053.1893621275863, 1164.6680696001768, 1256.3027519726456, 1257.8930790882694, 1263.879931406515, 1274.7131895323478, 758.4084414156966, 768.1190980539703, 809.5264270401881, 882.3382463152635, 941.0683423410774, 4941.530554597308, 5812.941870581325, 5857.736401861926, 5884.499817515559, 5886.8822623547285, 822.3873214455269, 912.8087845361733, 934.6495064350869, 948.3598570964709, 955.0401846144719, 3863.1307955710304, 3917.9804100979313, 3961.0493481564217, 3987.720859539804, 3998.3802510610903, 10520.26358154937, 10563.841542376871, 10793.78412431747, 10883.619073332395, 10891.183161262938, 10676.985686359783, 10790.67627971162, 10801.189910756724, 10854.34873907568, 10889.401082940356, 8100.918990810134, 8228.01263848342, 8317.0, 8343.332533397313, 8344.123866994, 5654.915176272277, 5782.5952183348445, 5801.709914504174, 5841.591088623925, 5850.853728656818, 10045.899541004788, 10185.745356365855, 10185.796284074426, 10188.745281368025, 10189.337693049929, 9603.615855365986, 10071.69784906454, 10077.143442807443, 10077.596896124072, 10325.380477171393, 6625.4037136657935, 6838.0, 7528.247175282647, 7713.845723085619, 7880.133185349721, 8238.423310368216, 8315.542645154575, 8342.957130358705, 8418.326533877398, 8433.915660843313, 7177.605231712306, 7309.342159205697, 7435.144958329862, 7484.288992545699, 7593.240675932362, 7037.859242815218, 7188.317109874553, 7200.279972002758, 7298.781036568911, 7416.925830741624, 6884.380405763505, 6923.89614155778, 6975.3024697529845, 6988.510804243654, 6990.790276291719, 4204.684648651302, 4825.445073816556, 4884.462709101925, 4908.410990680998, 5041.6470847040355, 4992.975035124947, 5001.274815151855, 5023.974880125576, 5035.697858128524, 5124.564412024871], "value": 4528.680416346697, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.58806640868806, 300.51616896796156, 306.2252501172034, 307.630842988414, 311.434745936126, 4217.388478670591, 4934.876628084291, 5313.388960269565, 5484.643498172616, 5544.805931792388, 4936.753162341886, 5446.809361672343, 5479.972600137004, 5489.533389661873, 5493.670379777216, 3394.6775056369606, 3934.645881870631, 3973.6225058619384, 4143.233501802161, 4156.023334516386, 3881.8059097045175, 4076.8776936691947, 4119.155573107506, 4136.317507611256, 4140.275451795938, 4087.366458198969, 4116.0121570823085, 4116.217918595472, 4120.743173332133, 4158.355454904495, 3254.900589120028, 3343.0, 3875.399313106473, 4033.878983630481, 4117.97941010296, 3262.8857989970475, 3280.852361643732, 3547.3682106231163, 3568.660977207161, 3589.730770192246, 5254.238135470374, 5270.4729527047375, 5281.445448227958, 5331.680099194022, 5383.031054410205, 3902.453656488094, 3932.7247092703524, 4399.472063352418, 4728.361671174382, 4744.905101897977, 5260.210968354739, 5472.703927416958, 5558.360788509332, 5592.636478628876, 5644.943550564483, 3295.0609076413107, 3295.7692961492703, 3441.63862794408, 3925.7644541327613, 3996.820937823349, 4915.483874193194, 5003.949960500421, 5234.7120908350025, 5631.465010823965, 5948.572342637823, 4014.337634290368, 4039.1315867088715, 4043.5754245804355, 4045.3122969094734, 4056.9797151014645, 3408.642092580293, 4019.738716983387, 4102.446169767043, 4158.6673066155245, 4166.291730405838, 4155.937660935088, 4218.240716671029, 4785.0, 4786.688865223749, 4790.712557246577, 5650.5479561634975, 5712.371639119693, 5712.914306285409, 5725.562688916123, 5738.311402631627, 1358.9932050339685, 1413.5264686330195, 1416.194352200952, 1418.44680574576, 1424.8957058279916, 716.8315445870217, 767.0833354141747, 863.620007196844, 879.4327658660128, 881.3918396306528, 4730.88172795676, 5063.012712521023, 5112.539871411516, 5264.394594621591, 5288.206768984683, 4824.517548245218, 4912.231596625212, 5876.3536011039605, 5913.9112913306335, 5935.673537955454, 4913.968066706032, 4972.701637901665, 5275.076861549213, 5293.015119330251, 5303.0, 2446.849980509158, 2542.8601426921696, 2647.689393750106, 2877.0, 3021.7280444760077, 5350.047232760015, 5484.215891035173, 5561.694106824082, 5837.460704593515, 6131.957567213584, 5234.97382513085, 5668.959174697188, 6002.429769171922, 6014.7594096236535, 6026.9095963560585, 5269.947300527022, 5458.9454105458435, 6038.215032045806, 6049.637021778707, 6068.757249709962, 4454.420925279693, 5875.676837773964, 5895.4399332063385, 5917.319508256433, 5929.102687140246, 5331.920021199608, 5876.471117599436, 5881.117832325014, 5905.498032667271, 5924.7037648118285, 5658.85852853682, 5680.77276908919, 6136.7852125175405, 6185.165002724754, 6185.597936134137, 3696.297703436446, 3926.411038344271, 3928.253631809947, 3945.5204298388103, 3959.8416063357145, 5874.559408044499, 5890.967616172414, 5927.755171414052, 5943.970280148572, 6004.699765011645, 5410.431904649955, 5430.723779911797, 5756.8987319627195, 5762.164486149569, 5775.566832487496, 5160.767765450639, 5208.635395522277, 5524.502794748492, 5702.0, 5761.724118972898, 4874.341963834837, 4939.753012349296, 5376.865578360415, 5594.608377413705, 5633.014222511126, 4682.555157260055, 4978.60171186297, 5170.405403378509, 5647.378788333198, 5739.454751798572, 4916.434610019894, 5609.242752228397, 5629.211910332639, 5630.915536266877, 5647.237622921018], "value": 4112.789625495158, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.9712811487541, 752.8870669399589, 782.4718315137285, 816.7014447029222, 837.1252041616513, 14765.704685906276, 15789.131597762118, 15830.920845395785, 15873.206339683013, 15901.1254381009, 15359.07845529269, 16103.677926441464, 16104.11427371494, 16114.516564503054, 16122.274497647604, 677.1265068062194, 843.1484200957016, 861.3367706865741, 868.5700578213794, 870.2254993056185, 698.9475789315821, 840.6595328891808, 849.6219182463806, 867.5792240763225, 870.3211495033884, 887.1350433327518, 889.977750556238, 890.1721399098835, 891.8127193289417, 893.1604291965564, 706.2725392845377, 885.6059053721096, 886.2112719679491, 886.5744442667491, 888.0409158109259, 647.8607099473588, 650.5738741124524, 652.9379708927644, 667.562746401108, 670.8893032649607, 15218.771718424232, 15222.771658425132, 15275.465358712392, 15281.006734562217, 15286.0, 10335.844962325496, 12399.504019839196, 12638.620841374774, 12726.300053497054, 12852.357382130856, 12857.742845143044, 12947.546835860794, 13076.476940922352, 13127.474901003949, 13620.591382258548, 4567.771611419415, 4607.331917064065, 4655.072088963585, 4722.315264286659, 4818.301346304801, 111626.44186779096, 112338.43830780794, 112956.0, 114192.0, 115256.62690357908, 11281.605143819927, 11359.488823002985, 11384.373859437645, 11463.0, 11566.768664626828, 22443.663345049838, 22457.663135052662, 22511.0, 22541.661875071888, 22777.08891644349, 7806.453548251568, 7839.686412543549, 7859.253370929752, 8006.798130514155, 8041.67833286662, 4356.76037817923, 4358.891027724332, 4436.3123715824095, 4509.842155524541, 4530.79611417487, 3418.9829050854587, 3543.557055368079, 3544.167120726627, 3546.0, 3554.129238336624, 564.5540023381483, 656.937590928861, 657.523295610688, 659.7756762700704, 666.7066490744057, 512.3314075131989, 548.7859734703469, 603.1676286724293, 620.2618883528677, 633.6166619195412, 8977.775555611031, 9047.68333108338, 9096.586282180002, 9100.726978190665, 9156.221721153777, 536.7826030457671, 589.4400319696306, 609.8505866062843, 623.5821999260506, 626.8432891777056, 3836.9256608149763, 3978.9403158952637, 4236.661067114624, 4306.1172459645695, 4358.782060896942, 143726.0, 146986.26506867397, 151546.0, 153597.23201384145, 154735.0, 81398.0, 94691.0, 124466.0, 127745.0, 130847.34576327057, 111471.44264278626, 112716.0, 113042.43478782718, 113121.0, 113700.29449558264, 8347.916520834713, 8549.572521374032, 8618.396712230084, 8819.691310804092, 8852.513111778913, 52844.0, 54658.90682186255, 58923.41076589351, 62074.37925620686, 63686.36313636804, 85052.57473712592, 88098.55950720461, 93254.0, 94621.0, 96660.0, 11470.197086203885, 11493.48279327449, 11515.712107197387, 11521.53913843437, 11720.120990925545, 11426.94286528562, 12019.699507512381, 12200.357603558119, 12244.326562038817, 12490.562830300896, 9958.900410995797, 11765.647030589096, 11767.117466189899, 11828.585999489977, 12086.972607328476, 11357.97778199966, 11439.942800285946, 11573.132015098732, 11908.404579770804, 11924.523019079139, 11447.942760286145, 11538.711532211762, 11948.761024779282, 12011.978981786646, 12078.818817717565, 9564.218593736043, 9864.16154626836, 10107.595696172071, 10281.228907832092, 10287.125594324267, 8810.89863767029, 9269.490178040272, 9432.339736218399, 9933.751656208364, 10075.647352342632], "value": 7559.753498209987, "unit": "score"}], "name": "dromaeo_css", "value": 7249.25681050175, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 112.0, 112.0, 112.0, 112.0, 114.0, 111.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 107.0, 159.0, 107.0, 106.0, 127.0, 106.0, 142.0, 110.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 184.0, 184.0, 186.0, 186.0, 183.0, 183.0, 185.0, 183.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 52.0, 88.0, 59.0, 59.0, 67.0, 61.0, 85.0, 58.0], "value": 68.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 127.0, 101.0, 71.0, 75.0, 71.0, 96.0, 76.0, 85.0, 136.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 89.0, 86.0, 90.0, 88.0, 89.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 84.0, 86.0, 85.0, 85.0, 88.0, 86.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 55.0, 53.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 78.0, 71.0, 71.0, 71.0, 72.0, 72.0, 74.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 88.0, 83.0, 97.0, 75.0, 82.0, 82.0, 70.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 122.0, 143.0, 121.0, 145.0, 151.0, 146.0, 219.0, 138.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 158.0, 214.0, 175.0, 163.0, 160.0, 162.0, 162.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 64.0, 65.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1435.6000000000001, "alertThreshold": 2.0}]} 08:26:08 INFO - Return code: 0 08:26:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:26:08 INFO - # TBPL SUCCESS # 08:26:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:26:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:26:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:26:08 INFO - 2016-06-30 08:26:08.339 screenresolution[2006:13408] starting screenresolution argv=screenresolution get 08:26:08 INFO - 2016-06-30 08:26:08.341 screenresolution[2006:13408] Display 0: 1600x1200x32@60 08:26:08 INFO - 2016-06-30 08:26:08.347 screenresolution[2007:13411] starting screenresolution argv=screenresolution list 08:26:08 INFO - Available Modes on Display 0 08:26:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:26:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:26:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:26:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:26:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:26:08 INFO - Intel Iris: 08:26:08 INFO - Chipset Model: Intel Iris 08:26:08 INFO - Type: GPU 08:26:08 INFO - Bus: Built-In 08:26:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:26:08 INFO - Vendor: Intel (0x8086) 08:26:08 INFO - Device ID: 0x0a2e 08:26:08 INFO - Revision ID: 0x0009 08:26:08 INFO - Displays: 08:26:08 INFO - Display: 08:26:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:26:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:26:08 INFO - Display Serial Number: 1600x1200 60 08:26:08 INFO - Main Display: Yes 08:26:08 INFO - Mirror: Off 08:26:08 INFO - Online: Yes 08:26:08 INFO - Rotation: Supported 08:26:08 INFO - Return code: 0 08:26:08 INFO - Running post-action listener: _resource_record_post_action 08:26:08 INFO - ##### 08:26:08 INFO - ##### Finished run-tests step (success) 08:26:08 INFO - ##### 08:26:08 INFO - Running post-run listener: _resource_record_post_run 08:26:08 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 540672; Write bytes: 706144256; Read time: 9; Write time: 1876 08:26:08 INFO - TinderboxPrint: CPU usage
53.3% 08:26:08 INFO - TinderboxPrint: I/O read bytes / time
540,672 / 9 08:26:08 INFO - TinderboxPrint: I/O write bytes / time
706,144,256 / 1,876 08:26:08 INFO - TinderboxPrint: CPU idle
2,262.6 (46.7%) 08:26:08 INFO - TinderboxPrint: CPU system
969.2 (20.0%) 08:26:08 INFO - TinderboxPrint: CPU user
1,617.8 (33.4%) 08:26:08 INFO - TinderboxPrint: Swap in / out
407,162,880 / 0 08:26:08 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 400237056; Write bytes: 397361152; Read time: 30260; Write time: 832 08:26:08 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 479232; Write bytes: 292861952; Read time: 8; Write time: 1002 08:26:09 INFO - Running post-run listener: _upload_blobber_files 08:26:09 INFO - Blob upload gear active. 08:26:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:09 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 08:26:09 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'] 08:26:09 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 08:26:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:10 INFO - (blobuploader) - INFO - Done attempting. 08:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:11 INFO - (blobuploader) - INFO - Done attempting. 08:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:13 INFO - (blobuploader) - INFO - Done attempting. 08:26:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:13 INFO - Return code: 0 08:26:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7fa1b435f8b4b5dad6d3fede342e7b41706b200173c8a0d40e8e0c6412c5b3cc16335b9b78869c7504b8ca1d0be2e66d11f517760a82aa014ee2bdc42bb5f51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1b2092fc5ed018a6db81b336db70676b152434cd27655c434b69a585dce847d3078db4bc20b544221d141c71410a8b2dce0732ed81458fa0801c93b78586b1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88556df67026fb06f3eaba933ad071add4a158bfa2f918e3fe2328774c208525b66b579f3e1677f1a7ddc73b2c2eb62dec10cbd5de5a3620d093765e6fb0e69c"} 08:26:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:13 INFO - Contents: 08:26:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7fa1b435f8b4b5dad6d3fede342e7b41706b200173c8a0d40e8e0c6412c5b3cc16335b9b78869c7504b8ca1d0be2e66d11f517760a82aa014ee2bdc42bb5f51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1b2092fc5ed018a6db81b336db70676b152434cd27655c434b69a585dce847d3078db4bc20b544221d141c71410a8b2dce0732ed81458fa0801c93b78586b1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88556df67026fb06f3eaba933ad071add4a158bfa2f918e3fe2328774c208525b66b579f3e1677f1a7ddc73b2c2eb62dec10cbd5de5a3620d093765e6fb0e69c"} 08:26:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:13 INFO - Copying logs to upload dir... 08:26:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.218943 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-30 08:26:13.454233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 08:26:13.458210) ========= 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.4ws3T3TsJp/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.KAew8qA1kv/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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/f7fa1b435f8b4b5dad6d3fede342e7b41706b200173c8a0d40e8e0c6412c5b3cc16335b9b78869c7504b8ca1d0be2e66d11f517760a82aa014ee2bdc42bb5f51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1b2092fc5ed018a6db81b336db70676b152434cd27655c434b69a585dce847d3078db4bc20b544221d141c71410a8b2dce0732ed81458fa0801c93b78586b1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88556df67026fb06f3eaba933ad071add4a158bfa2f918e3fe2328774c208525b66b579f3e1677f1a7ddc73b2c2eb62dec10cbd5de5a3620d093765e6fb0e69c"} build_url:https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010794 build_url: 'https://queue.taskcluster.net/v1/task/MCgy3AF3QxuRHQb8GJxCHw/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/f7fa1b435f8b4b5dad6d3fede342e7b41706b200173c8a0d40e8e0c6412c5b3cc16335b9b78869c7504b8ca1d0be2e66d11f517760a82aa014ee2bdc42bb5f51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1b2092fc5ed018a6db81b336db70676b152434cd27655c434b69a585dce847d3078db4bc20b544221d141c71410a8b2dce0732ed81458fa0801c93b78586b1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88556df67026fb06f3eaba933ad071add4a158bfa2f918e3fe2328774c208525b66b579f3e1677f1a7ddc73b2c2eb62dec10cbd5de5a3620d093765e6fb0e69c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 08:26:13.490132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:26:13.490459) ========= 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.4ws3T3TsJp/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.KAew8qA1kv/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.004534 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 08:26:13.538961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 08:26:13.539315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 08:26:13.539674) ========= ========= Total master_lag: 0.18 =========