builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0277 starttime: 1467694438.16 results: success (0) buildid: 20160704205822 builduid: e662c191b8b44a5f80766d601c4cd09f revision: 652fa69526ff82afbe7b7e6a360709c457fddf19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.156441) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.156980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.157297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.276983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.277331) ========= 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.AbI8kGJkXj/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.2YcV0gY84v/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-04 21:53: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% 196M=0s 2016-07-04 21:53:58 (196 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.515038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.816890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.817251) ========= 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.AbI8kGJkXj/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.2YcV0gY84v/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.025454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:53:58.869179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 21:53:58.870024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 652fa69526ff82afbe7b7e6a360709c457fddf19 --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 652fa69526ff82afbe7b7e6a360709c457fddf19 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AbI8kGJkXj/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.2YcV0gY84v/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-04 21:53:58,954 truncating revision to first 12 chars 2016-07-04 21:53:58,955 Setting DEBUG logging. 2016-07-04 21:53:58,955 attempt 1/10 2016-07-04 21:53:58,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/652fa69526ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 21:54:00,096 unpacking tar archive at: fx-team-652fa69526ff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.420779 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 21:54:00.315522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 21:54:00.315887) ========= script_repo_revision: 652fa69526ff82afbe7b7e6a360709c457fddf19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 21:54:00.316321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 21:54:00.316629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 21:54:00.334785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-04 21:54:00.335198) ========= /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.AbI8kGJkXj/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.2YcV0gY84v/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:00 INFO - MultiFileLogger online at 20160704 21:54:00 in /builds/slave/test 21:54:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:54:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:54:00 INFO - {'append_to_log': False, 21:54:00 INFO - 'base_work_dir': '/builds/slave/test', 21:54:00 INFO - 'blob_upload_branch': 'Fx-Team', 21:54:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:54:00 INFO - 'branch': 'Fx-Team', 21:54:00 INFO - 'buildbot_json_path': 'buildprops.json', 21:54:00 INFO - 'config_files': ('talos/mac_config.py',), 21:54:00 INFO - 'default_actions': ('clobber', 21:54:00 INFO - 'read-buildbot-config', 21:54:00 INFO - 'download-and-extract', 21:54:00 INFO - 'populate-webroot', 21:54:00 INFO - 'create-virtualenv', 21:54:00 INFO - 'install', 21:54:00 INFO - 'run-tests'), 21:54:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:54:00 INFO - 'download_minidump_stackwalk': True, 21:54:00 INFO - 'download_symbols': 'ondemand', 21:54:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:54:00 INFO - 'tooltool.py': '/tools/tooltool.py', 21:54:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:54:00 INFO - '/tools/misc-python/virtualenv.py')}, 21:54:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:54:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:54:00 INFO - 'installer_path': 'installer.exe', 21:54:00 INFO - 'log_level': 'info', 21:54:00 INFO - 'log_name': 'talos', 21:54:00 INFO - 'log_to_console': True, 21:54:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:54:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:54:00 INFO - 'opt_config_files': (), 21:54:00 INFO - 'pip_index': False, 21:54:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:54:00 INFO - 'cmd': ('bash', 21:54:00 INFO - '-c', 21:54:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:54:00 INFO - 'enabled': True, 21:54:00 INFO - 'halt_on_failure': False, 21:54:00 INFO - 'name': 'check_screen_resolution'},), 21:54:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:54:00 INFO - 'cmd': ('bash', 21:54:00 INFO - '-c', 21:54:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:54:00 INFO - 'enabled': True, 21:54:00 INFO - 'halt_on_failure': False, 21:54:00 INFO - 'name': 'check_screen_resolution'},), 21:54:00 INFO - 'run_cmd_checks_enabled': True, 21:54:00 INFO - 'sps_profile': False, 21:54:00 INFO - 'sps_profile_interval': 0, 21:54:00 INFO - 'suite': 'dromaeojs', 21:54:00 INFO - 'system_bits': '32', 21:54:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:54:00 INFO - 'title': 't-yosemite-r7-0277', 21:54:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:54:00 INFO - 'use_talos_json': True, 21:54:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:54:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:54:00 INFO - 'work_dir': 'build'} 21:54:00 INFO - ##### 21:54:00 INFO - ##### Running clobber step. 21:54:00 INFO - ##### 21:54:00 INFO - Running pre-action listener: _resource_record_pre_action 21:54:00 INFO - Running main action method: clobber 21:54:00 INFO - rmtree: /builds/slave/test/build 21:54:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:54:02 INFO - Running post-action listener: _resource_record_post_action 21:54:02 INFO - ##### 21:54:02 INFO - ##### Finished clobber step (success) 21:54:02 INFO - ##### 21:54:02 INFO - ##### 21:54:02 INFO - ##### Running read-buildbot-config step. 21:54:02 INFO - ##### 21:54:02 INFO - Running pre-action listener: _resource_record_pre_action 21:54:02 INFO - Running main action method: read_buildbot_config 21:54:02 INFO - Using buildbot properties: 21:54:02 INFO - { 21:54:02 INFO - "project": "", 21:54:02 INFO - "product": "firefox", 21:54:02 INFO - "script_repo_revision": "production", 21:54:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 21:54:02 INFO - "repository": "", 21:54:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 21:54:02 INFO - "buildid": "20160704205822", 21:54:02 INFO - "pgo_build": "False", 21:54:02 INFO - "basedir": "/builds/slave/test", 21:54:02 INFO - "buildnumber": 88, 21:54:02 INFO - "slavename": "t-yosemite-r7-0277", 21:54:02 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 21:54:02 INFO - "platform": "yosemite_r7", 21:54:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 21:54:02 INFO - "branch": "fx-team", 21:54:02 INFO - "repo_path": "integration/fx-team", 21:54:02 INFO - "revision": "652fa69526ff82afbe7b7e6a360709c457fddf19", 21:54:02 INFO - "stage_platform": "macosx64", 21:54:02 INFO - "builduid": "e662c191b8b44a5f80766d601c4cd09f", 21:54:02 INFO - "slavebuilddir": "test" 21:54:02 INFO - } 21:54:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 21:54:02 INFO - Running post-action listener: _resource_record_post_action 21:54:02 INFO - ##### 21:54:02 INFO - ##### Finished read-buildbot-config step (success) 21:54:02 INFO - ##### 21:54:02 INFO - ##### 21:54:02 INFO - ##### Running download-and-extract step. 21:54:02 INFO - ##### 21:54:02 INFO - Running pre-action listener: _resource_record_pre_action 21:54:02 INFO - Running main action method: download_and_extract 21:54:02 INFO - mkdir: /builds/slave/test/build/tests 21:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:02 INFO - https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:54:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 21:54:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 21:54:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:06 INFO - Downloaded 1199 bytes. 21:54:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 21:54:06 INFO - Using the following test package requirements: 21:54:06 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 21:54:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 21:54:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 21:54:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'jsshell-mac.zip'], 21:54:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 21:54:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 21:54:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 21:54:06 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 21:54:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 21:54:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:54:06 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 21:54:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:06 INFO - https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:54:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:54:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:54:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:08 INFO - Downloaded 18800160 bytes. 21:54:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:54:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:54:11 INFO - Return code: 0 21:54:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:11 INFO - https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:54:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:54:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:54:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:13 INFO - Downloaded 18800160 bytes. 21:54:13 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'] 21:54:13 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 21:54:17 INFO - Return code: 0 21:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:54:17 INFO - https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:54:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 21:54:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 21:54:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:19 INFO - Downloaded 14403333 bytes. 21:54:19 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'] 21:54:19 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 21:54:19 INFO - Return code: 0 21:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:19 INFO - https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 21:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjaQ8DfUQa2AChH28p3lew/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 21:54:23 INFO - Downloaded 112429186 bytes. 21:54:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:54:23 INFO - mkdir: /builds/slave/test/properties 21:54:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:54:23 INFO - Writing to file /builds/slave/test/properties/build_url 21:54:23 INFO - Contents: 21:54:23 INFO - build_url:https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:54:24 INFO - Running post-action listener: _resource_record_post_action 21:54:24 INFO - Running post-action listener: set_extra_try_arguments 21:54:24 INFO - ##### 21:54:24 INFO - ##### Finished download-and-extract step (success) 21:54:24 INFO - ##### 21:54:24 INFO - ##### 21:54:24 INFO - ##### Running populate-webroot step. 21:54:24 INFO - ##### 21:54:24 INFO - Running pre-action listener: _resource_record_pre_action 21:54:24 INFO - Running main action method: populate_webroot 21:54:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:54:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:54:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:54:24 INFO - '--tppagecycles', 21:54:24 INFO - '7'], 21:54:24 INFO - 'tests': ['tsvgm']}}, 21:54:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:54:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:54:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:54:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:54:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['damp', 'tps']}, 21:54:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'tests': ['damp', 'tps']}, 21:54:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['dromaeo_dom']}, 21:54:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:54:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['basic_compositor_video']}, 21:54:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:54:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['a11yr', 21:54:24 INFO - 'ts_paint', 21:54:24 INFO - 'tpaint', 21:54:24 INFO - 'sessionrestore', 21:54:24 INFO - 'sessionrestore_no_auto_restore', 21:54:24 INFO - 'tabpaint']}, 21:54:24 INFO - 'other-e10s': {'tests': ['a11yr', 21:54:24 INFO - 'ts_paint', 21:54:24 INFO - 'tpaint', 21:54:24 INFO - 'sessionrestore', 21:54:24 INFO - 'sessionrestore_no_auto_restore', 21:54:24 INFO - 'tabpaint']}, 21:54:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:54:24 INFO - 'ts_paint', 21:54:24 INFO - 'tpaint', 21:54:24 INFO - 'sessionrestore', 21:54:24 INFO - 'sessionrestore_no_auto_restore', 21:54:24 INFO - 'tabpaint']}, 21:54:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:54:24 INFO - 'ts_paint', 21:54:24 INFO - 'tpaint', 21:54:24 INFO - 'sessionrestore', 21:54:24 INFO - 'sessionrestore_no_auto_restore', 21:54:24 INFO - 'tabpaint']}, 21:54:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['a11yr', 21:54:24 INFO - 'ts_paint', 21:54:24 INFO - 'tpaint', 21:54:24 INFO - 'sessionrestore', 21:54:24 INFO - 'sessionrestore_no_auto_restore', 21:54:24 INFO - 'tabpaint']}, 21:54:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['a11yr', 21:54:24 INFO - 'ts_paint', 21:54:24 INFO - 'tpaint', 21:54:24 INFO - 'sessionrestore', 21:54:24 INFO - 'sessionrestore_no_auto_restore', 21:54:24 INFO - 'tabpaint']}, 21:54:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['tsvgx', 21:54:24 INFO - 'tsvgr_opacity', 21:54:24 INFO - 'tart', 21:54:24 INFO - 'tscrollx', 21:54:24 INFO - 'cart']}, 21:54:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:54:24 INFO - 'tsvgr_opacity', 21:54:24 INFO - 'tart', 21:54:24 INFO - 'tscrollx', 21:54:24 INFO - 'cart']}, 21:54:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'talos_options': ['--disable-e10s'], 21:54:24 INFO - 'tests': ['tp5o']}, 21:54:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'tests': ['tp5o']}, 21:54:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'talos_options': ['--disable-e10s', 21:54:24 INFO - '--xperf_path', 21:54:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:24 INFO - 'tests': ['tp5n']}, 21:54:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:24 INFO - 'talos_options': ['--xperf_path', 21:54:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:24 INFO - 'tests': ['tp5n']}}, 21:54:24 INFO - 'talos.zip': {'path': '', 21:54:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:54:24 INFO - Running post-action listener: _resource_record_post_action 21:54:24 INFO - ##### 21:54:24 INFO - ##### Finished populate-webroot step (success) 21:54:24 INFO - ##### 21:54:24 INFO - ##### 21:54:24 INFO - ##### Running create-virtualenv step. 21:54:24 INFO - ##### 21:54:24 INFO - Running pre-action listener: _resource_record_pre_action 21:54:24 INFO - Running main action method: create_virtualenv 21:54:24 INFO - Creating virtualenv /builds/slave/test/build/venv 21:54:24 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 21:54:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:54:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:54:24 INFO - Using real prefix '/tools/python27' 21:54:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:54:25 INFO - Installing distribute.............................................................................................................................................................................................done. 21:54:28 INFO - Installing pip.................done. 21:54:28 INFO - Return code: 0 21:54:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:54:28 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')]} 21:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:28 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')]} 21:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:28 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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:28 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 21:54:28 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 21:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:28 INFO - 'HOME': '/Users/cltbld', 21:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:28 INFO - 'LOGNAME': 'cltbld', 21:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:28 INFO - 'MOZ_NO_REMOTE': '1', 21:54:28 INFO - 'NO_EM_RESTART': '1', 21:54:28 INFO - 'PAGER': '/bin/cat', 21:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:28 INFO - 'PWD': '/builds/slave/test', 21:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:28 INFO - 'SHELL': '/bin/bash', 21:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:28 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:28 INFO - 'USER': 'cltbld', 21:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:28 INFO - 'XPC_FLAGS': '0x0', 21:54:28 INFO - 'XPC_SERVICE_NAME': '0', 21:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:28 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 21:54:28 INFO - Cleaning up... 21:54:28 INFO - Return code: 0 21:54:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:54:28 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')]} 21:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:28 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')]} 21:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:28 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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:28 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 21:54:28 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 21:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:28 INFO - 'HOME': '/Users/cltbld', 21:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:28 INFO - 'LOGNAME': 'cltbld', 21:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:28 INFO - 'MOZ_NO_REMOTE': '1', 21:54:28 INFO - 'NO_EM_RESTART': '1', 21:54:28 INFO - 'PAGER': '/bin/cat', 21:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:28 INFO - 'PWD': '/builds/slave/test', 21:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:28 INFO - 'SHELL': '/bin/bash', 21:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:28 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:28 INFO - 'USER': 'cltbld', 21:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:28 INFO - 'XPC_FLAGS': '0x0', 21:54:28 INFO - 'XPC_SERVICE_NAME': '0', 21:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:28 INFO - Downloading/unpacking psutil>=3.1.1 21:54:28 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 21:54:28 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 21:54:28 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 21:54:28 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 21:54:28 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 21:54:28 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 21:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:54:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:31 INFO - Installing collected packages: psutil 21:54:31 INFO - Running setup.py install for psutil 21:54:32 INFO - building 'psutil._psutil_osx' extension 21:54:32 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 21:54:32 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 21:54:32 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 21:54:32 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 21:54:32 INFO - building 'psutil._psutil_posix' extension 21:54:32 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 21:54:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:54:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:54:32 INFO - ^ 21:54:32 INFO - 1 warning generated. 21:54:32 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 21:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:33 INFO - Successfully installed psutil 21:54:33 INFO - Cleaning up... 21:54:33 INFO - Return code: 0 21:54:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:54:33 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')]} 21:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:33 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')]} 21:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:33 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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:33 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 21:54:33 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 21:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:33 INFO - 'HOME': '/Users/cltbld', 21:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:33 INFO - 'LOGNAME': 'cltbld', 21:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:33 INFO - 'MOZ_NO_REMOTE': '1', 21:54:33 INFO - 'NO_EM_RESTART': '1', 21:54:33 INFO - 'PAGER': '/bin/cat', 21:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:33 INFO - 'PWD': '/builds/slave/test', 21:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:33 INFO - 'SHELL': '/bin/bash', 21:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:33 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:33 INFO - 'USER': 'cltbld', 21:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:33 INFO - 'XPC_FLAGS': '0x0', 21:54:33 INFO - 'XPC_SERVICE_NAME': '0', 21:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:54:33 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 21:54:33 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 21:54:33 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 21:54:33 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 21:54:33 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 21:54:33 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 21:54:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:54:35 INFO - Installing collected packages: mozsystemmonitor 21:54:35 INFO - Running setup.py install for mozsystemmonitor 21:54:36 INFO - Successfully installed mozsystemmonitor 21:54:36 INFO - Cleaning up... 21:54:36 INFO - Return code: 0 21:54:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:36 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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:36 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 21:54:36 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 21:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:36 INFO - 'HOME': '/Users/cltbld', 21:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:36 INFO - 'LOGNAME': 'cltbld', 21:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:36 INFO - 'MOZ_NO_REMOTE': '1', 21:54:36 INFO - 'NO_EM_RESTART': '1', 21:54:36 INFO - 'PAGER': '/bin/cat', 21:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:36 INFO - 'PWD': '/builds/slave/test', 21:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:36 INFO - 'SHELL': '/bin/bash', 21:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:36 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:36 INFO - 'USER': 'cltbld', 21:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:36 INFO - 'XPC_FLAGS': '0x0', 21:54:36 INFO - 'XPC_SERVICE_NAME': '0', 21:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:36 INFO - Downloading/unpacking jsonschema==2.5.1 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:36 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 21:54:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:54:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:39 INFO - Downloading functools32-3.2.3-2.tar.gz 21:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:54:39 INFO - warning: no files found matching '*.txt' 21:54:39 INFO - no previously-included directories found matching 'build' 21:54:39 INFO - no previously-included directories found matching 'dist' 21:54:39 INFO - no previously-included directories found matching '.git*' 21:54:39 INFO - Installing collected packages: jsonschema, functools32 21:54:39 INFO - Running setup.py install for functools32 21:54:39 INFO - warning: no files found matching '*.txt' 21:54:39 INFO - no previously-included directories found matching 'build' 21:54:39 INFO - no previously-included directories found matching 'dist' 21:54:39 INFO - no previously-included directories found matching '.git*' 21:54:39 INFO - Successfully installed jsonschema functools32 21:54:39 INFO - Cleaning up... 21:54:39 INFO - Return code: 0 21:54:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:39 INFO - 'HOME': '/Users/cltbld', 21:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:39 INFO - 'LOGNAME': 'cltbld', 21:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:39 INFO - 'MOZ_NO_REMOTE': '1', 21:54:39 INFO - 'NO_EM_RESTART': '1', 21:54:39 INFO - 'PAGER': '/bin/cat', 21:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:39 INFO - 'PWD': '/builds/slave/test', 21:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:39 INFO - 'SHELL': '/bin/bash', 21:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:39 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:39 INFO - 'USER': 'cltbld', 21:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:39 INFO - 'XPC_FLAGS': '0x0', 21:54:39 INFO - 'XPC_SERVICE_NAME': '0', 21:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:39 INFO - Downloading/unpacking blobuploader==1.2.4 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:42 INFO - Downloading blobuploader-1.2.4.tar.gz 21:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:54:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:54:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:43 INFO - Downloading docopt-0.6.1.tar.gz 21:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:54:43 INFO - Installing collected packages: blobuploader, requests, docopt 21:54:43 INFO - Running setup.py install for blobuploader 21:54:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:54:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:54:43 INFO - Running setup.py install for requests 21:54:44 INFO - Running setup.py install for docopt 21:54:44 INFO - Successfully installed blobuploader requests docopt 21:54:44 INFO - Cleaning up... 21:54:44 INFO - Return code: 0 21:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:44 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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:44 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 21:54:44 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 21:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:44 INFO - 'HOME': '/Users/cltbld', 21:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:44 INFO - 'LOGNAME': 'cltbld', 21:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:44 INFO - 'MOZ_NO_REMOTE': '1', 21:54:44 INFO - 'NO_EM_RESTART': '1', 21:54:44 INFO - 'PAGER': '/bin/cat', 21:54:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:44 INFO - 'PWD': '/builds/slave/test', 21:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:44 INFO - 'SHELL': '/bin/bash', 21:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:44 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:44 INFO - 'USER': 'cltbld', 21:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:44 INFO - 'XPC_FLAGS': '0x0', 21:54:44 INFO - 'XPC_SERVICE_NAME': '0', 21:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:54:44 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5bj9w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:54:44 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-b1Rves-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:54:44 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-GNGe4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-cl7tBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-s6MsvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-njtj8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-eT3iQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-8HSBqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-1LEeK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-vpa4G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-27oi9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:54:45 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-WYTTO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:54:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-mrmlqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:54:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-6MxD_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-_w5esP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:54:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-X4P_6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:54:46 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-_OjOR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:54:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:54:46 INFO - Running setup.py install for manifestparser 21:54:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:54:46 INFO - Running setup.py install for mozcrash 21:54:46 INFO - Running setup.py install for mozdebug 21:54:46 INFO - Running setup.py install for mozdevice 21:54:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Running setup.py install for mozfile 21:54:47 INFO - Running setup.py install for mozhttpd 21:54:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Running setup.py install for mozinfo 21:54:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Running setup.py install for mozInstall 21:54:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:54:47 INFO - Running setup.py install for mozleak 21:54:47 INFO - Running setup.py install for mozlog 21:54:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:54:48 INFO - Running setup.py install for moznetwork 21:54:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:54:48 INFO - Running setup.py install for mozprocess 21:54:48 INFO - Running setup.py install for mozprofile 21:54:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:54:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:54:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:54:48 INFO - Running setup.py install for mozrunner 21:54:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:54:48 INFO - Running setup.py install for mozscreenshot 21:54:48 INFO - Running setup.py install for moztest 21:54:48 INFO - Running setup.py install for mozversion 21:54:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:54:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:54:49 INFO - Cleaning up... 21:54:49 INFO - Return code: 0 21:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:54: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')]} 21:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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')]} 21:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54: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 21:54: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 21:54:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:49 INFO - 'HOME': '/Users/cltbld', 21:54:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:49 INFO - 'LOGNAME': 'cltbld', 21:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:49 INFO - 'MOZ_NO_REMOTE': '1', 21:54:49 INFO - 'NO_EM_RESTART': '1', 21:54:49 INFO - 'PAGER': '/bin/cat', 21:54:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:49 INFO - 'PWD': '/builds/slave/test', 21:54:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:49 INFO - 'SHELL': '/bin/bash', 21:54:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:49 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:49 INFO - 'USER': 'cltbld', 21:54:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:49 INFO - 'XPC_FLAGS': '0x0', 21:54:49 INFO - 'XPC_SERVICE_NAME': '0', 21:54:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:54:49 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-KkLvqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:54:49 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)) 21:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:54:49 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-_h0L_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:54:49 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)) 21:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:54:49 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-aWDDnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:54:49 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)) 21:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:54:49 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-rnRtsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:54:49 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)) 21:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:54:49 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-TWc35y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:54:49 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)) 21:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:54:49 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-XccUgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:54: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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-RFY5me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qjZ124-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-7_q_Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Jp5o5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-I0h2Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ByEB0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-yxekzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Aljx2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-EEcYAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:54:50 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)) 21:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:54:50 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-IY_ZYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:54: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)) 21:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:54:51 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-VD4zSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:54:51 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)) 21:54:51 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)) 21:54:51 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)) 21:54:51 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)) 21:54:51 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)) 21:54:51 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)) 21:54:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:53 INFO - Downloading blessings-1.6.tar.gz 21:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:54:53 INFO - Installing collected packages: blessings 21:54:53 INFO - Running setup.py install for blessings 21:54:53 INFO - Successfully installed blessings 21:54:53 INFO - Cleaning up... 21:54:54 INFO - Return code: 0 21:54:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:54:54 INFO - Reading from file tmpfile_stdout 21:54:54 INFO - Current package versions: 21:54:54 INFO - blessings == 1.6 21:54:54 INFO - blobuploader == 1.2.4 21:54:54 INFO - docopt == 0.6.1 21:54:54 INFO - functools32 == 3.2.3-2 21:54:54 INFO - jsonschema == 2.5.1 21:54:54 INFO - manifestparser == 1.1 21:54:54 INFO - mozInstall == 1.12 21:54:54 INFO - mozcrash == 0.17 21:54:54 INFO - mozdebug == 0.1 21:54:54 INFO - mozdevice == 0.48 21:54:54 INFO - mozfile == 1.2 21:54:54 INFO - mozhttpd == 0.7 21:54:54 INFO - mozinfo == 0.9 21:54:54 INFO - mozleak == 0.1 21:54:54 INFO - mozlog == 3.2 21:54:54 INFO - moznetwork == 0.27 21:54:54 INFO - mozprocess == 0.22 21:54:54 INFO - mozprofile == 0.28 21:54:54 INFO - mozrunner == 6.11 21:54:54 INFO - mozscreenshot == 0.1 21:54:54 INFO - mozsystemmonitor == 0.3 21:54:54 INFO - moztest == 0.7 21:54:54 INFO - mozversion == 1.4 21:54:54 INFO - psutil == 3.1.1 21:54:54 INFO - requests == 1.2.3 21:54:54 INFO - wsgiref == 0.1.2 21:54:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:54:54 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')]} 21:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:54 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')]} 21:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:54 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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:54 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 21:54:54 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 21:54:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:54 INFO - 'HOME': '/Users/cltbld', 21:54:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:54 INFO - 'LOGNAME': 'cltbld', 21:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:54 INFO - 'MOZ_NO_REMOTE': '1', 21:54:54 INFO - 'NO_EM_RESTART': '1', 21:54:54 INFO - 'PAGER': '/bin/cat', 21:54:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:54 INFO - 'PWD': '/builds/slave/test', 21:54:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:54 INFO - 'SHELL': '/bin/bash', 21:54:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:54 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:54 INFO - 'USER': 'cltbld', 21:54:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:54 INFO - 'XPC_FLAGS': '0x0', 21:54:54 INFO - 'XPC_SERVICE_NAME': '0', 21:54:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 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)) 21:54:54 INFO - Cleaning up... 21:54:54 INFO - Return code: 0 21:54:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:54:54 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')]} 21:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:54 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')]} 21:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:54 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 0x10815ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081f1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8733d75420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, '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.AbI8kGJkXj/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.2YcV0gY84v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 21:54:54 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 21:54:54 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 21:54:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:54:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:54:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:54:54 INFO - 'HOME': '/Users/cltbld', 21:54:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:54:54 INFO - 'LOGNAME': 'cltbld', 21:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:54 INFO - 'MOZ_NO_REMOTE': '1', 21:54:54 INFO - 'NO_EM_RESTART': '1', 21:54:54 INFO - 'PAGER': '/bin/cat', 21:54:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:54 INFO - 'PWD': '/builds/slave/test', 21:54:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:54:54 INFO - 'SHELL': '/bin/bash', 21:54:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:54:54 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:54:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:54:54 INFO - 'USER': 'cltbld', 21:54:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:54:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:54 INFO - 'XPC_FLAGS': '0x0', 21:54:54 INFO - 'XPC_SERVICE_NAME': '0', 21:54:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:54:54 INFO - Cleaning up... 21:54:54 INFO - Return code: 0 21:54:54 INFO - Running post-action listener: _resource_record_post_action 21:54:54 INFO - Running post-action listener: _start_resource_monitoring 21:54:54 INFO - Starting resource monitoring. 21:54:54 INFO - ##### 21:54:54 INFO - ##### Finished create-virtualenv step (success) 21:54:54 INFO - ##### 21:54:54 INFO - ##### 21:54:54 INFO - ##### Running install step. 21:54:54 INFO - ##### 21:54:54 INFO - Running pre-action listener: _resource_record_pre_action 21:54:54 INFO - Running main action method: install 21:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:54:55 INFO - Reading from file tmpfile_stdout 21:54:55 INFO - Detecting whether we're running mozinstall >=1.0... 21:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:54:55 INFO - Reading from file tmpfile_stdout 21:54:55 INFO - Output received: 21:54:55 INFO - Usage: mozinstall [options] installer 21:54:55 INFO - Options: 21:54:55 INFO - -h, --help show this help message and exit 21:54:55 INFO - -d DEST, --destination=DEST 21:54:55 INFO - Directory to install application into. [default: 21:54:55 INFO - "/builds/slave/test"] 21:54:55 INFO - --app=APP Application being installed. [default: firefox] 21:54:55 INFO - mkdir: /builds/slave/test/build/application 21:54:55 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'] 21:54:55 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 21:55:29 INFO - Reading from file tmpfile_stdout 21:55:29 INFO - Output received: 21:55:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:55:29 INFO - Running post-action listener: _resource_record_post_action 21:55:29 INFO - ##### 21:55:29 INFO - ##### Finished install step (success) 21:55:29 INFO - ##### 21:55:29 INFO - ##### 21:55:29 INFO - ##### Running run-tests step. 21:55:29 INFO - ##### 21:55:29 INFO - Running pre-action listener: _resource_record_pre_action 21:55:29 INFO - Running main action method: run_tests 21:55:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:55:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:55:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:55:29 INFO - 2016-07-04 21:55:29.877 screenresolution[1649:7894] starting screenresolution argv=screenresolution get 21:55:29 INFO - 2016-07-04 21:55:29.880 screenresolution[1649:7894] Display 0: 1600x1200x32@60 21:55:29 INFO - 2016-07-04 21:55:29.886 screenresolution[1650:7896] starting screenresolution argv=screenresolution list 21:55:29 INFO - Available Modes on Display 0 21:55:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:55:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:55:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:55:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:55:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:55:30 INFO - Intel Iris: 21:55:30 INFO - Chipset Model: Intel Iris 21:55:30 INFO - Type: GPU 21:55:30 INFO - Bus: Built-In 21:55:30 INFO - VRAM (Dynamic, Max): 1536 MB 21:55:30 INFO - Vendor: Intel (0x8086) 21:55:30 INFO - Device ID: 0x0a2e 21:55:30 INFO - Revision ID: 0x0009 21:55:30 INFO - Displays: 21:55:30 INFO - Display: 21:55:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:55:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:55:30 INFO - Display Serial Number: 1600x1200 60 21:55:30 INFO - Main Display: Yes 21:55:30 INFO - Mirror: Off 21:55:30 INFO - Online: Yes 21:55:30 INFO - Rotation: Supported 21:55:30 INFO - Return code: 0 21:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:55:30 INFO - Python 2.7.3 21:55:30 INFO - Return code: 0 21:55:30 INFO - grabbing minidump binary from tooltool 21:55:30 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')]} 21:55:30 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 0x1080c0d30>, '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 0x107e25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080b8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:55:30 INFO - Return code: 0 21:55:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:55:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:55:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:55:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:55:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:55:30 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/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 21:55:30 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/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 21:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbI8kGJkXj/Render', 21:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:30 INFO - 'HOME': '/Users/cltbld', 21:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:30 INFO - 'LOGNAME': 'cltbld', 21:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:30 INFO - 'MOZ_NO_REMOTE': '1', 21:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:55:30 INFO - 'NO_EM_RESTART': '1', 21:55:30 INFO - 'PAGER': '/bin/cat', 21:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:30 INFO - 'PWD': '/builds/slave/test', 21:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:30 INFO - 'SHELL': '/bin/bash', 21:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YcV0gY84v/Listeners', 21:55:30 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 21:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:30 INFO - 'USER': 'cltbld', 21:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:30 INFO - 'XPC_FLAGS': '0x0', 21:55:30 INFO - 'XPC_SERVICE_NAME': '0', 21:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:30 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/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 21:55:30 INFO - mozversion application_buildid: 20160704205822 21:55:30 INFO - mozversion application_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 21:55:30 INFO - mozversion application_display_name: Nightly 21:55:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:55:30 INFO - mozversion application_name: Firefox 21:55:30 INFO - mozversion application_remotingname: firefox 21:55:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:55:30 INFO - mozversion application_vendor: Mozilla 21:55:30 INFO - mozversion application_version: 50.0a1 21:55:30 INFO - mozversion platform_buildid: 20160704205822 21:55:30 INFO - mozversion platform_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 21:55:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:55:30 INFO - mozversion platform_version: 50.0a1 21:55:30 INFO - using testdate: 1467694530 21:55:30 INFO - actual date: 1467694530 21:55:30 INFO - starting webserver on 'localhost:49278' 21:55:30 INFO - SUITE-START | Running 2 tests 21:55:30 INFO - TEST-START | dromaeo_css 21:55:30 INFO - operating with platform_type : mac_ 21:55:30 INFO - Initialising browser for dromaeo_css test... 21:55:30 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpAjcOK0/profile http://localhost:49278/getInfo.html) 21:55:33 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 21:55:33 INFO - PROCESS | 1660 | colorDepth:24 21:55:33 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 21:55:33 INFO - PROCESS | 1660 | __metrics 21:55:33 INFO - PROCESS | 1660 | 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" 21:55:33 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:55:33 INFO - TEST-INFO | 1660: exit 0 21:55:33 INFO - Browser initialized. 21:55:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:55:33 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpAjcOK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:46 INFO - PROCESS | 1663 | RSS: Main: 243744768 21:55:46 INFO - PROCESS | 1663 | 21:56:37 INFO - PROCESS | 1663 | 1467694597583 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] 21:58:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 21:58:49 INFO - PROCESS | 1663 | RSS: Main: 425922560 21:58:49 INFO - PROCESS | 1663 | 22:01:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 22:01:53 INFO - PROCESS | 1663 | RSS: Main: 374059008 22:01:53 INFO - PROCESS | 1663 | 22:04:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 22:04:56 INFO - PROCESS | 1663 | RSS: Main: 373174272 22:04:56 INFO - PROCESS | 1663 | 22:07:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 22:07:58 INFO - PROCESS | 1663 | RSS: Main: 370597888 22:07:58 INFO - PROCESS | 1663 | 22:11:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 22:11:02 INFO - PROCESS | 1663 | RSS: Main: 341704704 22:11:02 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 22:14:06 INFO - PROCESS | 1663 | RSS: Main: 401178624 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | __start_tp_report 22:14:06 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 22:14:06 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 22:14:06 INFO - PROCESS | 1663 | |i|pagename|runs| 22:14:06 INFO - PROCESS | 1663 | |0;dojo.html;3413.6757008084223;3421.2473255883706;3440.86236550538;3445.6037555681105;3501.737369697273;5735.168400581913;5839.445252700986;5851.356350801414;5907.556933230009;5932.7923522676665;5754.712264386785;5849.590528662995;5859.267591551056;5862.501687356569;5913.999999999989;5232.686038837663;5280.498352656491;5314.176302673091;5320.14877619581;5431.266778984846;5373.596980226479;5407.594430417715;5424.321959755031;5443.537299329561;5451.37309209442;5229.2156176573435;5269.262303277545;5280.841574752763;5316.73416329184;5329.573634109262;5279.128943724281;5303.522682958553;5305.761240744176;5341.946580534222;5358.383785864637;5301.416844147141;5319.946800531984;5333.493318134771;5357.4106848246665;5391.29913111293;5799.449052340021;5878.147668588031;5891.293044834647;5949.048152295655;5973.6415815050805;6330.493560515148;6361.61830290184;6372.267189273247;6374.87250254997;6390.712417941204;6290.465310448617;6325.240971083454;6334.461570766491;6346.841328966767;6380.393862583047;5832.12518122285;5919.526437884959;5992.250968628921;6002.399760023963;6011.458968692838;6341;6349.206349206349;6349.269833969152;6363.300036995926;6367.586106903036;6127.6782420562195;6246.3441338659695;6301.936980630227;6321.620702757849;6342.23893132827;6224.284207316216;6304.936950630527;6307.432331090224;6360.14138091361;6370.394812492806;6264.310925798159;6309.652969086745;6314.905276420857;6324.620522768649;6325.209348831396;6200.193974783339;6258.030005349178;6330;6353.745850166034;6371.745130194833;5054.721990290569;5058.317127187856;5060.291559181717;5067.746612669352;5101.183810590288;4504.752238626841;4538.704984176084;4551.931721024187;4557.635389168859;4609.308603709471;5712.257406537206;5715.571332150105;5797.971010144923;5903.085021821625;5956.315023772322;6225.782097626561;6339.397757213057;6352.872942541123;6363.077353783676;6367.299597044322;5869.559783016291;5890.941090589039;5906.852328691817;5946.345901950782;5949.732262048218;5513.365962914236;5529.972350138223;5530.198121272393;5531.115021596525;5546.889062218814;6230.096635987847;6263.27972283175;6313.936860631335;6369.5222858285815;6386.744530218833;6234.75060997555;6293;6333.050042493663;6354.142190804368;6368.363163683594;6364.077208804605;6368.808935731936;6377.362263773585;6385.616862988236;6389.9041514376395;6154.076888466766;6329.461995730415;6349.6507692077375;6356.078368636614;6383.87232255343;5321.467853214647;6246.437820596168;6324.873502530016;6356.014817703263;6378.394052564999;6227.097070924781;6227.657478838526;6250.781222657185;6255.56211065221;6265.310815810349;6049.667268300285;6082.787102451393;6301.4643755279485;6301.590396624205;6304.621722696653;6024.277086749443;6037;6057.454829065406;6077.544184186116;6083.026715725463;6197.845053873689;6210.161628180138;6211.378862113933;6236.6258024518675;6249.50003999688;6160.7535698571555;6184.628922264498;6188.040853667689;6197.25632924052;6204 22:14:06 INFO - PROCESS | 1663 | |1;ext.html;466.219083035915;479.53724655707236;498.623539227883;513.4736894682948;518.7328525809206;30684.84657576712;43219.78390108049;44049.559504404984;44070.559294407125;46640.30039549401;45440.3183952241;45677.543224567744;45800.77099614497;45807.54192458074;45942.081158376815;8391.370647201455;9154.450732956011;9810.26423018271;9999.600015999351;10003.399796012263;8840.513771742551;9067.727968160933;9073.818523629523;9075.500847453388;9107.772305692344;10172.338797978146;11977.880221197807;12200.145989780718;12434.191777534432;12445.128840981135;12124.939375303155;12196.146269761164;12201;12201.816972745415;12222.02223822101;8757.649694012232;11724;11994.760104797942;12088.879111208951;12179.39103044853;42768.57231427677;43114.78442607798;43181.568184318385;43191.704248872586;43236;3167.6357218919657;3541.061618671054;3600.9099772505633;3612.4400717888507;3968.8482851579934;27592.724072759218;31665.36669266602;33438.498422523684;33490;33580.83209583961;2874.648915009942;3304.3886880927107;3411.4712219605753;3423.2811109667;3452.430348992413;529360;530111;530399;531891;531893;66016;66137.6693116541;66151;66754.33245667578;66771;68565.65717171383;68598;68623;68685.65657171683;68710.5644717762;15307.387704491695;17181.828181718272;17435.30258789634;17444.47666570005;17456.214470348867;11913.761724765629;12234.388280585936;12240.693982650506;12287.13990020708;12998.415071321813;18427.355042573447;19003.334883279018;19082.236710531422;19096.904515477334;19125.043747812553;5076.3908330999775;6415.230172379251;6486.44865186455;6492.383223593751;6535.117759102461;944.622151139536;1055.894410558938;1079.1690398393193;1083.5820895522388;1109.9722506937392;31439.37121257562;31699.04902852918;31804.045878623216;32331.51502727461;32614.83692581522;1064.882862885082;1067.8024565455416;1109.5118148014847;1145.4158379226653;1150.71232191952;16427.507174784776;16453.42413015539;16518.174091295386;16599.3360265588;16998.490045298662;699719;726026;745442;745474;1022902;64393;64643;64931;65110.348896510426;65129.348706512326;1280.8206851040861;1310.541310541303;1401.7827236778317;1426.964325891861;1440.9495667651581;23310.76689233086;32564.697412104197;32565.674343256265;33704.3259134811;34864.30271394507;51152.48847511626;61463;62045.68977155085;62247.37752622416;62308.376916230256;640666.7966660137;645207;648144;649057;651441;27370.86314568494;27396.493192874583;27778.166655000383;27856.582151268154;28868.42263154767;37103.81448092742;37582.62417375791;50795.74602126966;52951.20573191482;54886.72556637191;41691.58308416877;42097;42389.78805105955;42966.71099867009;43812;42121;42326.36510452407;42453.787731061144;42941.35587966246;43554.782226089934;40605;40762;41153.55962541296;41288.174236515704;43209;33652.831735841166;35797.82101089478;36564.45153322649;36701.81649091737;36823.63176368202;26108.8694556526;26172.8691356542;26426;26601;26717.465650687267 22:14:06 INFO - PROCESS | 1663 | |2;jquery.html;386.64235582086565;386.9477620521229;389.48585889540226;391.45196724585577;407.6229487723855;15327.386904523806;16320.755188672165;18279.634407311878;20176.69734953975;21261.36215913523;16931.238094285756;18091.09544522775;20590.588188236226;20904.581908361823;21338.46653833655;5693.402192769761;5897.587168898179;5926.259217597801;5931.436513531229;5933.22868027158;5616.52259557936;5779.335376431701;5873.941260587403;5885.058390657496;5896.145058966447;5813.82558523245;5827.592068555203;5834.329052158992;5836.795712150076;5839.182514447981;5562.249096371998;5819.854503637401;5821.18503409523;5823.767049318022;5826.359100498963;5062.848114556569;5086.643934924557;5087.618428617869;5089.949100508985;5094.6688465249645;24851;25905;26099.478010439874;26121.346966325804;26301.47397052048;2440.1093600835743;2477.095860011101;2711.9322016949536;3142.795718278305;3190.3778763141195;15146.242687865562;15718.52844414658;15876.841231587652;16258.674826503522;16534.503964881074;1775.8934463932205;1834.2204563060645;1847.9815201848078;1862.1620270878025;1893.2427029188298;63609.68195158995;74478;74998.25001749967;116591.99999999916;116613;10426.218033647507;10586.20603454744;10675.519601617945;10893.509792059376;11102.000819926085;13535.052546321664;13669.38487768033;13669.453221871212;13697.041207115606;13701.520446784514;7796.220377962271;7799.727009554638;8550.74347769568;8741.213290803858;8773.561321933877;8847.513386763661;8852.557372131369;8858.955705221562;8959.10408959112;8976.68581599654;6522.315156908551;6618.371254730793;6622.966885165543;6631.900521492182;6640.103586015923;1836.9540761480803;1872.382113902409;1875.6342513210066;1876.6434377468238;1877.3992322456684;908.7455512456522;924.5839372282366;961.9422834629945;1011.3503713086486;1044.9477526123815;17422.128893555273;22147.224847130274;22216.444588885082;22228.666570001464;22265.998030088685;959.194276807485;992.6823416506649;999.8750156230471;1008.1430783833829;1079.8164312066967;9555.18780903631;10238.641647542448;11789.823152652545;11878.940605297092;11966.102542309362;617957.9102104461;619204;629111;631185;632200;117833;118588.40705796416;121679;126488;129488.35255823661;1043.3426941027105;1055.4775386184042;1055.9366438013744;1071.5499490214129;1073.7637719701654;19529.8047019528;19670.60658786845;19814.90092549586;19866.60266794627;19881.502962426053;52501.7374913123;54762.45237547573;55274.75305184783;55342.44657553373;56394;74687;75214;77458.22541774735;77505.2249477498;78680;7942.761717148494;8106.432549721699;8189.22202390772;8210.712625058095;8459.280961118375;13561.796573051215;13648.727025459633;13699;13891.652708682364;13937.860621393656;11657.533698652298;11702.824457633313;11818.877206665353;11832.290062596272;11840.28958262507;11564.826527601925;11592.0146787524;11599.246049006788;11694.590689325832;11898.821517677416;11754.000909922752;11869.169158158846;11884.405779711153;11988.76022479528;11990.340531270514;8134.227248411392;8173.305269051959;8221.054578723524;8234.217749313806;8391.160883911803;11584.594539191088;11609.477573509044;11700.765984680429;11713.648590542298;11797.410129493663 22:14:06 INFO - PROCESS | 1663 | |3;mootools.html;1406.9155850648956;1552.9145896975665;1588.4281658602904;1815.7821061472616;1959.823615874571;7739.187385324537;8179.79550511236;8189.672413103469;8196.38527110467;8774.298056155509;8274.338052955763;8773.56132193391;8986.10138986101;8990.68532601359;9015.143561361676;2373.5608912351186;2412.6260429633435;2415.3237093613816;2415.372003279151;2418.1657328221736;2365.3613524348416;2401.0635852017726;2407.7712617301418;2409.4578719787996;2418.830681852271;2365.31405892291;2376.8591076283396;2391.0196819304088;2398.95202095958;2403.2910291463972;2338.3335749311536;2375.2755409600063;2377.049180327883;2380.27401642499;2384.332386931662;2336;2354.3054798834387;2358.563665721847;2361.964570531426;2365.7634236576378;8997.910020899839;9008.009118996904;9082.000979892207;9086.227670648002;9114.225290850285;5243.895122097575;5249.081410753103;5424.755885985141;5425.131978883399;5434.891302173974;3003.9399212015855;3560.3413368526644;3693.2059607184315;3708.5178926739623;3717.7211709121925;1092.9508172132273;1104.7735214281054;1108.5842808946645;1123.5449642894641;1125.2404626876908;11680.824787628193;11755.23590966593;11764.941175294154;11778.705532361673;11794.646160615195;4442.355858400579;4485.932711009337;4626.352310676508;4654.022655242369;4665.206914824488;9255.305852060988;9280.72157835266;9281.67514137002;9285.07149285066;9291.814163716823;5296.4703529647495;5299.8410047698635;5305.071612467803;5313.920291195635;5319.6808191508635;4445.422095127613;4595.862124136282;4770.42754869411;4934.506549345037;4954.5788607968725;3773.8490460381277;3783.45139954705;3866.6326698963553;3889.4360317753767;3900.297946369624;977.9804403911882;1140.1790710688292;1145.3700464744356;1153.8038533449335;1156.2022204678744;659.3735950846619;816.1715858403725;859.58739804894;928.6842473559022;932.8740620016347;5839.591228613956;6141.815745527641;6174.598651087755;6189.535784816157;6202.379762023762;426.22852636727623;480.22204029472476;497.7187888842792;498.81793145502354;642.293477175113;3639.9808053744996;3998.960010399917;4105.815238314283;4151.14901445203;4204.747715137101;10120.342177758423;10953.780924381468;10964.890351096386;10966.890331096587;10971.725706857393;10698.786024279627;10873.456327183609;10890;10927.453627318602;10956.013958743752;8277.006759188936;8348.540830254395;8362.958185209034;8382.916170838336;8385.748427547183;5785.479306862402;5922.644641321534;5946.762129514771;6065.272167339947;6175.59858609189;10025.849612255675;10097.697069087939;10138.645147419806;10182.032706892833;10199.439030853375;10395.480225988822;10409.86597747475;10431.895681043092;10463.215258855464;10469.110125639101;6946.270641582561;6953.965230173817;7008.474364422586;7014.807492660885;7075.610841403566;8316.792080198044;8353.33173346143;8402.41183117176;8416.284615807725;8443.620037098222;6208.72060757258;7479.813004674927;7701.075870895304;7720.961395192988;7769.805754856174;7498.662560184914;7587.582682952269;7697.422693298137;7704.26809453101;7715.614219289126;7194.964025179841;7200.099987501562;7284.890726639211;7293.197748247582;7295.343419092307;5010.3737032870895;5167.069927412951;5168.457311982188;5241;5265.842024739264;5190.2214667800135;5245.790168393221;5260.105782017143;5304.124819404909;5371.033214021513 22:14:06 INFO - PROCESS | 1663 | |4;prototype.html;258.7567686374808;305.46238620028754;318.21877291249984;323.91254361322444;326.19430007880527;4119.979400102995;4507.565914406221;5066.645334826564;5238;5319.973400132999;4295.484541854974;4728.787204575794;5147.38231412231;5227.921581176285;5236.581073514119;4000.5396681041098;4019.859304924328;4025.1748391579654;4033.1933613277315;4045.8786236412957;3495.615482296945;3746.8455638008118;4037.3943908413826;4040.2525532776385;4042.393640953851;3587.5694916609914;3952.7351247600777;4014.437978682987;4038;4042.3936409538655;3431.18147381888;3898.3762597984187;3978.542467616218;3987.9999999999854;4011.438398624195;3058.6906885301455;3358.7648864579487;3491.94762078569;3505.6319086495805;3511.5251594330443;4436.844710435152;4711.387519622462;5013.571132227335;5088.669236499616;5140.434552199255;3858.954753980395;4481.6638752093395;4519.457665080178;4527.253003254459;4546.340585686201;4837.080954618611;5235.612562670895;5521.944780552183;5524.779008839641;5549.528290095347;3804.2011177652726;3812.7885826221004;3814.275287695329;3821.3759152360412;3837.1581640812287;5705.971470142623;5737.856553586152;5815;5824.7476792489815;5836.620619659751;3851.78815165163;3861.4940173332425;3874.0314921269683;3874.380099184117;3875.8643447479203;3128.9361617050313;3886.203328317688;3894.6689531389584;3923.391409522082;3928.8821335359985;3797;4530.501644819134;4531.870021090082;4541.68208225421;4557.977210113994;4155.958440415618;5344.545713614309;5473.890522189534;5575.860603484945;5582.888342233214;1202.741410596726;1248.868868768766;1294.3398866577925;1319.327143156997;1327.4690123950497;816.5182542299953;831.8086840026707;845.9932680110649;867.9783005424915;894.7405252476839;4001.8399264029695;4396.868093957187;4466.865994020184;4513.638908887281;5032.106538740166;4818.253170758468;5024.894523204889;5413.296271484761;5568.9721551392795;5592.245046918695;4279.3738379416245;4682.18402002367;4983.156232194111;4994.825181118644;5000.199968005102;2514.968862766257;2548.4775620997652;2812.539028350194;2991.401719656034;2991.6559595646345;4959.801607935642;5264.947350526446;5795.449432304009;5842.065269556851;5861.413858614104;4251.553586873396;5136.614753893473;5573.491928632132;5814.302283725895;5967.134765459071;5454.318335123855;5910.8817823643285;5956.76172953077;5975.729222895272;5985.707860676611;4763.071201115749;5003.074431230234;5598.32820061579;5785.037249484117;5796.652200867961;4747.240441529339;5003.874903127451;5305.904167853753;5458.61789674719;5745.482906538432;5608.831735047955;5909.8227053188475;5925.259342582177;5930.881382372415;6101;3142.764292678104;3241.692039256267;3771.245750849786;3832.9233415332096;3838.673712734449;5226.059309324358;5676.290463692038;5711.257536520226;5720.369694637008;5733.770649173986;5293.062350395414;5532.474414930575;5548.140038294071;5570.415106413769;5606.719664016864;4896.36347274852;5222.843314700565;5542.196381524737;5564.91652625219;5621.353544342453;5014.749262536786;5435;5460.208269800777;5469.234307196916;5479;5328.706921119376;5491.368492623399;5571.3592936811165;5579.358373787067;5580.330360356783;4400.779961002001;5477.726113694379;5489.560835133259;5490.725463726718;5494.725263736877 22:14:06 INFO - PROCESS | 1663 | |5;yui.html;721.8195451137215;785.6464590934078;804.151620040857;816.0941355095842;817.1460823439505;15280.312385942632;16473;16486.917565412157;16487.917560412196;16553.586160345996;14611;14845.851541484582;14878.25608719565;14906.180160091191;14945.40218391263;716.323074694414;742.7660287009575;743.0266351080076;744.1776836595538;746.4998451037791;727.240034164297;733.8312188196718;921.8064206516606;924.5146298193436;928.5914197752967;951.4529145741192;970.5923512124889;971.2569884038716;971.3152227679504;972.9659461918834;958.4153666263574;961.20700422152;961.6441916490874;962.2206013129388;963.903609639034;563.6871536297353;695.523566357042;722.1911459165768;724.7825652304288;725.3725527418745;14412.927935360256;14440;14452.349644266033;14464.421423143061;14498.710025799424;11983.88016119845;13990.790138147935;14491.058081224792;14556.344964476624;14778.334974926154;11332.376719280437;11886.821697674455;11912.702182445422;12151;12217.144799864012;4714.929276060861;4715.622750180011;4750.263709125091;4754.714717116949;4945.727984960826;109717.9999999992;112840;113709.86290137075;114881;116426.25360619597;11209.55161793519;11596.01433878113;11842.88157118435;11922.225055371373;11945.283283003047;23006;23414.297571072893;23467.295981120595;23485.882570587037;23576.58139569753;8125;8170.428070035159;8341.624626891804;8460.492370457792;8486.618102185417;4358.978205108954;4443.466783985942;4479.260921947907;4488.371627972087;4647.1635105680625;3536.1159710072484;3626.3472574936764;3667.339878821838;3668.963310366862;3676.191237927652;673.0476375928105;677.1941389746187;678.8235058884726;679.7954650486755;680.9625470599066;595.2707932782394;603.3212635784743;657.1850904878013;659.9342062568917;666.2271764752863;8687.391882568287;8723.582765314188;9043.547822608843;9058.773530661654;9192.369014239339;556.6576555418388;607.1924340626956;665.8813193834404;672.3175976383974;675.2673349415841;3799.411091280856;4258.978705106455;4357.564243575617;4374.409454723572;4478.94744734987;144700.27649861682;146619.53380466058;147793;147927.26036369964;152668.20649728522;123506;123697;124538;126988;127716;104945.47527262468;106144;107376.92623073826;107517.46241268744;110197.44901275603;8392.916070839214;8836;8867.778305542413;9218.585163667785;9317.254619630548;47516.762416187696;50197;55455.445445545025;58004;62210;95437.52281238549;96156.78824088081;97094;98113.50943245238;99455;13766.793006965047;13863.861361386256;13914.373853176834;13926.651833703832;14244.786328204878;14089.718205636034;14213.50252741149;14253.328428106799;14649;14812.851871481578;12658.11393202467;12895.16181448203;13012.544560940321;13012.804807928078;13276.668083297995;11408.315501069963;12572.937135314265;12647;12886.355682215664;13093.476260949456;13003.08978371505;13037.936871452526;13046.412911419198;13152.369526094628;13619.795703064265;10404.167666586807;10426.739331516772;10482.423466709404;10545.52545135486;10790.67627971162;7418.629068546659;9879.456629885426;10795.6221532246;10938.781224375627;10994.725131871448 22:14:06 INFO - PROCESS | 1663 | __end_tp_report 22:14:06 INFO - PROCESS | 1663 | __start_cc_report 22:14:06 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1820 22:14:06 INFO - PROCESS | 1663 | __end_cc_report 22:14:06 INFO - PROCESS | 1663 | __startTimestamp1467695646430__endTimestamp 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | ------- Summary: start ------- 22:14:06 INFO - PROCESS | 1663 | Number of tests: 6 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5863.55 Median:6083.03 stddev:632.97 (10.4%) stddev-sans-first:605.03 22:14:06 INFO - PROCESS | 1663 | Values: 3413.7 3421.2 3440.9 3445.6 3501.7 5735.2 5839.4 5851.4 5907.6 5932.8 5754.7 5849.6 5859.3 5862.5 5914.0 5232.7 5280.5 5314.2 5320.1 5431.3 5373.6 5407.6 5424.3 5443.5 5451.4 5229.2 5269.3 5280.8 5316.7 5329.6 5279.1 5303.5 5305.8 5341.9 5358.4 5301.4 5319.9 5333.5 5357.4 5391.3 5799.4 5878.1 5891.3 5949.0 5973.6 6330.5 6361.6 6372.3 6374.9 6390.7 6290.5 6325.2 6334.5 6346.8 6380.4 5832.1 5919.5 5992.3 6002.4 6011.5 6341.0 6349.2 6349.3 6363.3 6367.6 6127.7 6246.3 6301.9 6321.6 6342.2 6224.3 6304.9 6307.4 6360.1 6370.4 6264.3 6309.7 6314.9 6324.6 6325.2 6200.2 6258.0 6330.0 6353.7 6371.7 5054.7 5058.3 5060.3 5067.7 5101.2 4504.8 4538.7 4551.9 4557.6 4609.3 5712.3 5715.6 5798.0 5903.1 5956.3 6225.8 6339.4 6352.9 6363.1 6367.3 5869.6 5890.9 5906.9 5946.3 5949.7 5513.4 5530.0 5530.2 5531.1 5546.9 6230.1 6263.3 6313.9 6369.5 6386.7 6234.8 6293.0 6333.1 6354.1 6368.4 6364.1 6368.8 6377.4 6385.6 6389.9 6154.1 6329.5 6349.7 6356.1 6383.9 5321.5 6246.4 6324.9 6356.0 6378.4 6227.1 6227.7 6250.8 6255.6 6265.3 6049.7 6082.8 6301.5 6301.6 6304.6 6024.3 6037.0 6057.5 6077.5 6083.0 6197.8 6210.2 6211.4 6236.6 6249.5 6160.8 6184.6 6188.0 6197.3 6204.0 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:79179.88 Median:37343.22 stddev:179006.28 (479.4%) stddev-sans-first:179410.88 22:14:06 INFO - PROCESS | 1663 | Values: 466.2 479.5 498.6 513.5 518.7 30684.8 43219.8 44049.6 44070.6 46640.3 45440.3 45677.5 45800.8 45807.5 45942.1 8391.4 9154.5 9810.3 9999.6 10003.4 8840.5 9067.7 9073.8 9075.5 9107.8 10172.3 11977.9 12200.1 12434.2 12445.1 12124.9 12196.1 12201.0 12201.8 12222.0 8757.6 11724.0 11994.8 12088.9 12179.4 42768.6 43114.8 43181.6 43191.7 43236.0 3167.6 3541.1 3600.9 3612.4 3968.8 27592.7 31665.4 33438.5 33490.0 33580.8 2874.6 3304.4 3411.5 3423.3 3452.4 529360.0 530111.0 530399.0 531891.0 531893.0 66016.0 66137.7 66151.0 66754.3 66771.0 68565.7 68598.0 68623.0 68685.7 68710.6 15307.4 17181.8 17435.3 17444.5 17456.2 11913.8 12234.4 12240.7 12287.1 12998.4 18427.4 19003.3 19082.2 19096.9 19125.0 5076.4 6415.2 6486.4 6492.4 6535.1 944.6 1055.9 1079.2 1083.6 1110.0 31439.4 31699.0 31804.0 32331.5 32614.8 1064.9 1067.8 1109.5 1145.4 1150.7 16427.5 16453.4 16518.2 16599.3 16998.5 699719.0 726026.0 745442.0 745474.0 1022902.0 64393.0 64643.0 64931.0 65110.3 65129.3 1280.8 1310.5 1401.8 1427.0 1440.9 23310.8 32564.7 32565.7 33704.3 34864.3 51152.5 61463.0 62045.7 62247.4 62308.4 640666.8 645207.0 648144.0 649057.0 651441.0 27370.9 27396.5 27778.2 27856.6 28868.4 37103.8 37582.6 50795.7 52951.2 54886.7 41691.6 42097.0 42389.8 42966.7 43812.0 42121.0 42326.4 42453.8 42941.4 43554.8 40605.0 40762.0 41153.6 41288.2 43209.0 33652.8 35797.8 36564.5 36701.8 36823.6 26108.9 26172.9 26426.0 26601.0 26717.5 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35138.47 Median:2458.60 stddev:103571.43 (4212.6%) stddev-sans-first:103829.10 22:14:06 INFO - PROCESS | 1663 | Values: 386.6 386.9 389.5 391.5 407.6 15327.4 16320.8 18279.6 20176.7 21261.4 16931.2 18091.1 20590.6 20904.6 21338.5 5693.4 5897.6 5926.3 5931.4 5933.2 5616.5 5779.3 5873.9 5885.1 5896.1 5813.8 5827.6 5834.3 5836.8 5839.2 5562.2 5819.9 5821.2 5823.8 5826.4 5062.8 5086.6 5087.6 5089.9 5094.7 24851.0 25905.0 26099.5 26121.3 26301.5 2440.1 2477.1 2711.9 3142.8 3190.4 15146.2 15718.5 15876.8 16258.7 16534.5 1775.9 1834.2 1848.0 1862.2 1893.2 63609.7 74478.0 74998.3 116592.0 116613.0 10426.2 10586.2 10675.5 10893.5 11102.0 13535.1 13669.4 13669.5 13697.0 13701.5 7796.2 7799.7 8550.7 8741.2 8773.6 8847.5 8852.6 8859.0 8959.1 8976.7 6522.3 6618.4 6623.0 6631.9 6640.1 1837.0 1872.4 1875.6 1876.6 1877.4 908.7 924.6 961.9 1011.4 1044.9 17422.1 22147.2 22216.4 22228.7 22266.0 959.2 992.7 999.9 1008.1 1079.8 9555.2 10238.6 11789.8 11878.9 11966.1 617957.9 619204.0 629111.0 631185.0 632200.0 117833.0 118588.4 121679.0 126488.0 129488.4 1043.3 1055.5 1055.9 1071.5 1073.8 19529.8 19670.6 19814.9 19866.6 19881.5 52501.7 54762.5 55274.8 55342.4 56394.0 74687.0 75214.0 77458.2 77505.2 78680.0 7942.8 8106.4 8189.2 8210.7 8459.3 13561.8 13648.7 13699.0 13891.7 13937.9 11657.5 11702.8 11818.9 11832.3 11840.3 11564.8 11592.0 11599.2 11694.6 11898.8 11754.0 11869.2 11884.4 11988.8 11990.3 8134.2 8173.3 8221.1 8234.2 8391.2 11584.6 11609.5 11700.8 11713.6 11797.4 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5733.93 Median:2726.15 stddev:3237.88 (118.8%) stddev-sans-first:3230.63 22:14:06 INFO - PROCESS | 1663 | Values: 1406.9 1552.9 1588.4 1815.8 1959.8 7739.2 8179.8 8189.7 8196.4 8774.3 8274.3 8773.6 8986.1 8990.7 9015.1 2373.6 2412.6 2415.3 2415.4 2418.2 2365.4 2401.1 2407.8 2409.5 2418.8 2365.3 2376.9 2391.0 2399.0 2403.3 2338.3 2375.3 2377.0 2380.3 2384.3 2336.0 2354.3 2358.6 2362.0 2365.8 8997.9 9008.0 9082.0 9086.2 9114.2 5243.9 5249.1 5424.8 5425.1 5434.9 3003.9 3560.3 3693.2 3708.5 3717.7 1093.0 1104.8 1108.6 1123.5 1125.2 11680.8 11755.2 11764.9 11778.7 11794.6 4442.4 4485.9 4626.4 4654.0 4665.2 9255.3 9280.7 9281.7 9285.1 9291.8 5296.5 5299.8 5305.1 5313.9 5319.7 4445.4 4595.9 4770.4 4934.5 4954.6 3773.8 3783.5 3866.6 3889.4 3900.3 978.0 1140.2 1145.4 1153.8 1156.2 659.4 816.2 859.6 928.7 932.9 5839.6 6141.8 6174.6 6189.5 6202.4 426.2 480.2 497.7 498.8 642.3 3640.0 3999.0 4105.8 4151.1 4204.7 10120.3 10953.8 10964.9 10966.9 10971.7 10698.8 10873.5 10890.0 10927.5 10956.0 8277.0 8348.5 8363.0 8382.9 8385.7 5785.5 5922.6 5946.8 6065.3 6175.6 10025.8 10097.7 10138.6 10182.0 10199.4 10395.5 10409.9 10431.9 10463.2 10469.1 6946.3 6954.0 7008.5 7014.8 7075.6 8316.8 8353.3 8402.4 8416.3 8443.6 6208.7 7479.8 7701.1 7721.0 7769.8 7498.7 7587.6 7697.4 7704.3 7715.6 7195.0 7200.1 7284.9 7293.2 7295.3 5010.4 5167.1 5168.5 5241.0 5265.8 5190.2 5245.8 5260.1 5304.1 5371.0 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4431.89 Median:4971.48 stddev:1380.68 (27.8%) stddev-sans-first:1348.56 22:14:06 INFO - PROCESS | 1663 | Values: 258.8 305.5 318.2 323.9 326.2 4120.0 4507.6 5066.6 5238.0 5320.0 4295.5 4728.8 5147.4 5227.9 5236.6 4000.5 4019.9 4025.2 4033.2 4045.9 3495.6 3746.8 4037.4 4040.3 4042.4 3587.6 3952.7 4014.4 4038.0 4042.4 3431.2 3898.4 3978.5 3988.0 4011.4 3058.7 3358.8 3491.9 3505.6 3511.5 4436.8 4711.4 5013.6 5088.7 5140.4 3859.0 4481.7 4519.5 4527.3 4546.3 4837.1 5235.6 5521.9 5524.8 5549.5 3804.2 3812.8 3814.3 3821.4 3837.2 5706.0 5737.9 5815.0 5824.7 5836.6 3851.8 3861.5 3874.0 3874.4 3875.9 3128.9 3886.2 3894.7 3923.4 3928.9 3797.0 4530.5 4531.9 4541.7 4558.0 4156.0 5344.5 5473.9 5575.9 5582.9 1202.7 1248.9 1294.3 1319.3 1327.5 816.5 831.8 846.0 868.0 894.7 4001.8 4396.9 4466.9 4513.6 5032.1 4818.3 5024.9 5413.3 5569.0 5592.2 4279.4 4682.2 4983.2 4994.8 5000.2 2515.0 2548.5 2812.5 2991.4 2991.7 4959.8 5264.9 5795.4 5842.1 5861.4 4251.6 5136.6 5573.5 5814.3 5967.1 5454.3 5910.9 5956.8 5975.7 5985.7 4763.1 5003.1 5598.3 5785.0 5796.7 4747.2 5003.9 5305.9 5458.6 5745.5 5608.8 5909.8 5925.3 5930.9 6101.0 3142.8 3241.7 3771.2 3832.9 3838.7 5226.1 5676.3 5711.3 5720.4 5733.8 5293.1 5532.5 5548.1 5570.4 5606.7 4896.4 5222.8 5542.2 5564.9 5621.4 5014.7 5435.0 5460.2 5469.2 5479.0 5328.7 5491.4 5571.4 5579.4 5580.3 4400.8 5477.7 5489.6 5490.7 5494.7 22:14:06 INFO - PROCESS | 1663 | 22:14:06 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:24728.62 Median:3668.15 stddev:39404.97 (1074.2%) stddev-sans-first:39474.28 22:14:06 INFO - PROCESS | 1663 | Values: 721.8 785.6 804.2 816.1 817.1 15280.3 16473.0 16486.9 16487.9 16553.6 14611.0 14845.9 14878.3 14906.2 14945.4 716.3 742.8 743.0 744.2 746.5 727.2 733.8 921.8 924.5 928.6 951.5 970.6 971.3 971.3 973.0 958.4 961.2 961.6 962.2 963.9 563.7 695.5 722.2 724.8 725.4 14412.9 14440.0 14452.3 14464.4 14498.7 11983.9 13990.8 14491.1 14556.3 14778.3 11332.4 11886.8 11912.7 12151.0 12217.1 4714.9 4715.6 4750.3 4754.7 4945.7 109718.0 112840.0 113709.9 114881.0 116426.3 11209.6 11596.0 11842.9 11922.2 11945.3 23006.0 23414.3 23467.3 23485.9 23576.6 8125.0 8170.4 8341.6 8460.5 8486.6 4359.0 4443.5 4479.3 4488.4 4647.2 3536.1 3626.3 3667.3 3669.0 3676.2 673.0 677.2 678.8 679.8 681.0 595.3 603.3 657.2 659.9 666.2 8687.4 8723.6 9043.5 9058.8 9192.4 556.7 607.2 665.9 672.3 675.3 3799.4 4259.0 4357.6 4374.4 4478.9 144700.3 146619.5 147793.0 147927.3 152668.2 123506.0 123697.0 124538.0 126988.0 127716.0 104945.5 106144.0 107376.9 107517.5 110197.4 8392.9 8836.0 8867.8 9218.6 9317.3 47516.8 50197.0 55455.4 58004.0 62210.0 95437.5 96156.8 97094.0 98113.5 99455.0 13766.8 13863.9 13914.4 13926.7 14244.8 14089.7 14213.5 14253.3 14649.0 14812.9 12658.1 12895.2 13012.5 13012.8 13276.7 11408.3 12572.9 12647.0 12886.4 13093.5 13003.1 13037.9 13046.4 13152.4 13619.8 10404.2 10426.7 10482.4 10545.5 10790.7 7418.6 9879.5 10795.6 10938.8 10994.7 22:14:06 INFO - PROCESS | 1663 | -------- Summary: end -------- 22:14:06 INFO - PROCESS | 1663 | 22:14:07 INFO - TEST-INFO | 1663: exit 0 22:14:07 INFO - TEST-OK | dromaeo_css | took 1116636ms 22:14:07 INFO - TEST-START | kraken 22:14:07 INFO - operating with platform_type : mac_ 22:14:07 INFO - Initialising browser for kraken test... 22:14:07 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpNGVvqp/profile http://localhost:49278/getInfo.html) 22:14:09 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 22:14:09 INFO - PROCESS | 1669 | colorDepth:24 22:14:09 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 22:14:09 INFO - PROCESS | 1669 | __metrics 22:14:09 INFO - PROCESS | 1669 | 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" 22:14:09 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:09 INFO - TEST-INFO | 1669: exit 0 22:14:09 INFO - Browser initialized. 22:14:09 INFO - Running cycle 1/1 for kraken test... 22:14:09 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpNGVvqp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:22 INFO - PROCESS | 1670 | RSS: Main: 244801536 22:14:22 INFO - PROCESS | 1670 | 22:14:24 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 22:14:25 INFO - PROCESS | 1670 | RSS: Main: 294309888 22:14:25 INFO - PROCESS | 1670 | 22:14:28 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 22:14:28 INFO - PROCESS | 1670 | RSS: Main: 304898048 22:14:28 INFO - PROCESS | 1670 | 22:14:32 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 22:14:32 INFO - PROCESS | 1670 | RSS: Main: 391917568 22:14:32 INFO - PROCESS | 1670 | 22:14:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 22:14:35 INFO - PROCESS | 1670 | RSS: Main: 291057664 22:14:35 INFO - PROCESS | 1670 | 22:14:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:14:38 INFO - PROCESS | 1670 | RSS: Main: 295542784 22:14:38 INFO - PROCESS | 1670 | 22:14:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 22:14:41 INFO - PROCESS | 1670 | RSS: Main: 332283904 22:14:41 INFO - PROCESS | 1670 | 22:14:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 22:14:45 INFO - PROCESS | 1670 | RSS: Main: 334176256 22:14:45 INFO - PROCESS | 1670 | 22:14:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 22:14:48 INFO - PROCESS | 1670 | RSS: Main: 333422592 22:14:48 INFO - PROCESS | 1670 | 22:14:50 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:14:50 INFO - PROCESS | 1670 | RSS: Main: 311762944 22:14:50 INFO - PROCESS | 1670 | 22:14:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:14:53 INFO - PROCESS | 1670 | RSS: Main: 318316544 22:14:53 INFO - PROCESS | 1670 | 22:14:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:14:56 INFO - PROCESS | 1670 | RSS: Main: 316198912 22:14:56 INFO - PROCESS | 1670 | 22:14:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:14:59 INFO - PROCESS | 1670 | RSS: Main: 325828608 22:14:59 INFO - PROCESS | 1670 | 22:15:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:15:03 INFO - PROCESS | 1670 | RSS: Main: 329973760 22:15:03 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 22:15:05 INFO - PROCESS | 1670 | RSS: Main: 373592064 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | __start_tp_report 22:15:05 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 22:15:05 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 22:15:05 INFO - PROCESS | 1670 | |i|pagename|runs| 22:15:05 INFO - PROCESS | 1670 | |0;ai-astar;101;113;113;112;114;112;111;112;112;112 22:15:05 INFO - PROCESS | 1670 | |1;audio-beat-detection;144;107;106;160;125;137;130;106;160;107 22:15:05 INFO - PROCESS | 1670 | |2;audio-dft;187;184;184;184;185;182;180;200;184;183 22:15:05 INFO - PROCESS | 1670 | |3;audio-fft;78;73;58;107;59;58;76;84;111;62 22:15:05 INFO - PROCESS | 1670 | |4;audio-oscillator;81;90;92;70;70;68;96;70;67;100 22:15:05 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;86;84;87;84;86;85;87;84;86;83 22:15:05 INFO - PROCESS | 1670 | |6;imaging-darkroom;93;92;93;93;93;98;93;94;93;93 22:15:05 INFO - PROCESS | 1670 | |7;imaging-desaturate;87;91;91;90;90;90;90;87;91;87 22:15:05 INFO - PROCESS | 1670 | |8;json-parse-financial;55;52;55;57;56;56;55;54;51;61 22:15:05 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;66;73;75;71;72;73;71;73;71;72 22:15:05 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;82;78;86;73;91;91;91;84;85;85 22:15:05 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;136;135;131;136;145;139;136;137;231;155 22:15:05 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;167;163;160;167;165;209;221;175;160;219 22:15:05 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;63;80;83;75;66;65;64;64;65;66 22:15:05 INFO - PROCESS | 1670 | __end_tp_report 22:15:05 INFO - PROCESS | 1670 | __start_cc_report 22:15:05 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2054 22:15:05 INFO - PROCESS | 1670 | __end_cc_report 22:15:05 INFO - PROCESS | 1670 | __startTimestamp1467695705311__endTimestamp 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | ------- Summary: start ------- 22:15:05 INFO - PROCESS | 1670 | Number of tests: 14 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.68 (3.3%) stddev-sans-first:0.87 22:15:05 INFO - PROCESS | 1670 | Values: 101.0 113.0 113.0 112.0 114.0 112.0 111.0 112.0 112.0 112.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:133.50 stddev:21.72 (16.3%) stddev-sans-first:22.28 22:15:05 INFO - PROCESS | 1670 | Values: 144.0 107.0 106.0 160.0 125.0 137.0 130.0 106.0 160.0 107.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:185.30 Median:184.00 stddev:5.48 (3.0%) stddev-sans-first:5.78 22:15:05 INFO - PROCESS | 1670 | Values: 187.0 184.0 184.0 184.0 185.0 182.0 180.0 200.0 184.0 183.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:76.60 Median:67.50 stddev:19.41 (28.8%) stddev-sans-first:20.59 22:15:05 INFO - PROCESS | 1670 | Values: 78.0 73.0 58.0 107.0 59.0 58.0 76.0 84.0 111.0 62.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:75.50 stddev:12.96 (17.2%) stddev-sans-first:13.75 22:15:05 INFO - PROCESS | 1670 | Values: 81.0 90.0 92.0 70.0 70.0 68.0 96.0 70.0 67.0 100.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.45 22:15:05 INFO - PROCESS | 1670 | Values: 86.0 84.0 87.0 84.0 86.0 85.0 87.0 84.0 86.0 83.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 22:15:05 INFO - PROCESS | 1670 | Values: 93.0 92.0 93.0 93.0 93.0 98.0 93.0 94.0 93.0 93.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:89.40 Median:90.00 stddev:1.71 (1.9%) stddev-sans-first:1.58 22:15:05 INFO - PROCESS | 1670 | Values: 87.0 91.0 91.0 90.0 90.0 90.0 90.0 87.0 91.0 87.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:2.74 (4.9%) stddev-sans-first:2.91 22:15:05 INFO - PROCESS | 1670 | Values: 55.0 52.0 55.0 57.0 56.0 56.0 55.0 54.0 51.0 61.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:2.36 (3.3%) stddev-sans-first:1.32 22:15:05 INFO - PROCESS | 1670 | Values: 66.0 73.0 75.0 71.0 72.0 73.0 71.0 73.0 71.0 72.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.50 stddev:5.87 (6.9%) stddev-sans-first:6.15 22:15:05 INFO - PROCESS | 1670 | Values: 82.0 78.0 86.0 73.0 91.0 91.0 91.0 84.0 85.0 85.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:138.00 stddev:29.89 (21.7%) stddev-sans-first:31.38 22:15:05 INFO - PROCESS | 1670 | Values: 136.0 135.0 131.0 136.0 145.0 139.0 136.0 137.0 231.0 155.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:171.00 stddev:25.20 (14.7%) stddev-sans-first:26.25 22:15:05 INFO - PROCESS | 1670 | Values: 167.0 163.0 160.0 167.0 165.0 209.0 221.0 175.0 160.0 219.0 22:15:05 INFO - PROCESS | 1670 | 22:15:05 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:66.00 stddev:7.37 (11.2%) stddev-sans-first:7.48 22:15:05 INFO - PROCESS | 1670 | Values: 63.0 80.0 83.0 75.0 66.0 65.0 64.0 64.0 65.0 66.0 22:15:05 INFO - PROCESS | 1670 | -------- Summary: end -------- 22:15:05 INFO - PROCESS | 1670 | 22:15:06 INFO - TEST-INFO | 1670: exit 0 22:15:06 INFO - TEST-OK | kraken | took 59040ms 22:15:06 INFO - SUITE-END | took 1175s 22:15:06 INFO - Completed test suite (00:19:36) 22:15:06 INFO - javascript benchmark 22:15:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3413.6757008084223, 3421.2473255883706, 3440.86236550538, 3445.6037555681105, 3501.737369697273, 5735.168400581913, 5839.445252700986, 5851.356350801414, 5907.556933230009, 5932.7923522676665, 5754.712264386785, 5849.590528662995, 5859.267591551056, 5862.501687356569, 5913.999999999989, 5232.686038837663, 5280.498352656491, 5314.176302673091, 5320.14877619581, 5431.266778984846, 5373.596980226479, 5407.594430417715, 5424.321959755031, 5443.537299329561, 5451.37309209442, 5229.2156176573435, 5269.262303277545, 5280.841574752763, 5316.73416329184, 5329.573634109262, 5279.128943724281, 5303.522682958553, 5305.761240744176, 5341.946580534222, 5358.383785864637, 5301.416844147141, 5319.946800531984, 5333.493318134771, 5357.4106848246665, 5391.29913111293, 5799.449052340021, 5878.147668588031, 5891.293044834647, 5949.048152295655, 5973.6415815050805, 6330.493560515148, 6361.61830290184, 6372.267189273247, 6374.87250254997, 6390.712417941204, 6290.465310448617, 6325.240971083454, 6334.461570766491, 6346.841328966767, 6380.393862583047, 5832.12518122285, 5919.526437884959, 5992.250968628921, 6002.399760023963, 6011.458968692838, 6341.0, 6349.206349206349, 6349.269833969152, 6363.300036995926, 6367.586106903036, 6127.6782420562195, 6246.3441338659695, 6301.936980630227, 6321.620702757849, 6342.23893132827, 6224.284207316216, 6304.936950630527, 6307.432331090224, 6360.14138091361, 6370.394812492806, 6264.310925798159, 6309.652969086745, 6314.905276420857, 6324.620522768649, 6325.209348831396, 6200.193974783339, 6258.030005349178, 6330.0, 6353.745850166034, 6371.745130194833, 5054.721990290569, 5058.317127187856, 5060.291559181717, 5067.746612669352, 5101.183810590288, 4504.752238626841, 4538.704984176084, 4551.931721024187, 4557.635389168859, 4609.308603709471, 5712.257406537206, 5715.571332150105, 5797.971010144923, 5903.085021821625, 5956.315023772322, 6225.782097626561, 6339.397757213057, 6352.872942541123, 6363.077353783676, 6367.299597044322, 5869.559783016291, 5890.941090589039, 5906.852328691817, 5946.345901950782, 5949.732262048218, 5513.365962914236, 5529.972350138223, 5530.198121272393, 5531.115021596525, 5546.889062218814, 6230.096635987847, 6263.27972283175, 6313.936860631335, 6369.5222858285815, 6386.744530218833, 6234.75060997555, 6293.0, 6333.050042493663, 6354.142190804368, 6368.363163683594, 6364.077208804605, 6368.808935731936, 6377.362263773585, 6385.616862988236, 6389.9041514376395, 6154.076888466766, 6329.461995730415, 6349.6507692077375, 6356.078368636614, 6383.87232255343, 5321.467853214647, 6246.437820596168, 6324.873502530016, 6356.014817703263, 6378.394052564999, 6227.097070924781, 6227.657478838526, 6250.781222657185, 6255.56211065221, 6265.310815810349, 6049.667268300285, 6082.787102451393, 6301.4643755279485, 6301.590396624205, 6304.621722696653, 6024.277086749443, 6037.0, 6057.454829065406, 6077.544184186116, 6083.026715725463, 6197.845053873689, 6210.161628180138, 6211.378862113933, 6236.6258024518675, 6249.50003999688, 6160.7535698571555, 6184.628922264498, 6188.040853667689, 6197.25632924052, 6204.0], "value": 5823.4515173182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.219083035915, 479.53724655707236, 498.623539227883, 513.4736894682948, 518.7328525809206, 30684.84657576712, 43219.78390108049, 44049.559504404984, 44070.559294407125, 46640.30039549401, 45440.3183952241, 45677.543224567744, 45800.77099614497, 45807.54192458074, 45942.081158376815, 8391.370647201455, 9154.450732956011, 9810.26423018271, 9999.600015999351, 10003.399796012263, 8840.513771742551, 9067.727968160933, 9073.818523629523, 9075.500847453388, 9107.772305692344, 10172.338797978146, 11977.880221197807, 12200.145989780718, 12434.191777534432, 12445.128840981135, 12124.939375303155, 12196.146269761164, 12201.0, 12201.816972745415, 12222.02223822101, 8757.649694012232, 11724.0, 11994.760104797942, 12088.879111208951, 12179.39103044853, 42768.57231427677, 43114.78442607798, 43181.568184318385, 43191.704248872586, 43236.0, 3167.6357218919657, 3541.061618671054, 3600.9099772505633, 3612.4400717888507, 3968.8482851579934, 27592.724072759218, 31665.36669266602, 33438.498422523684, 33490.0, 33580.83209583961, 2874.648915009942, 3304.3886880927107, 3411.4712219605753, 3423.2811109667, 3452.430348992413, 529360.0, 530111.0, 530399.0, 531891.0, 531893.0, 66016.0, 66137.6693116541, 66151.0, 66754.33245667578, 66771.0, 68565.65717171383, 68598.0, 68623.0, 68685.65657171683, 68710.5644717762, 15307.387704491695, 17181.828181718272, 17435.30258789634, 17444.47666570005, 17456.214470348867, 11913.761724765629, 12234.388280585936, 12240.693982650506, 12287.13990020708, 12998.415071321813, 18427.355042573447, 19003.334883279018, 19082.236710531422, 19096.904515477334, 19125.043747812553, 5076.3908330999775, 6415.230172379251, 6486.44865186455, 6492.383223593751, 6535.117759102461, 944.622151139536, 1055.894410558938, 1079.1690398393193, 1083.5820895522388, 1109.9722506937392, 31439.37121257562, 31699.04902852918, 31804.045878623216, 32331.51502727461, 32614.83692581522, 1064.882862885082, 1067.8024565455416, 1109.5118148014847, 1145.4158379226653, 1150.71232191952, 16427.507174784776, 16453.42413015539, 16518.174091295386, 16599.3360265588, 16998.490045298662, 699719.0, 726026.0, 745442.0, 745474.0, 1022902.0, 64393.0, 64643.0, 64931.0, 65110.348896510426, 65129.348706512326, 1280.8206851040861, 1310.541310541303, 1401.7827236778317, 1426.964325891861, 1440.9495667651581, 23310.76689233086, 32564.697412104197, 32565.674343256265, 33704.3259134811, 34864.30271394507, 51152.48847511626, 61463.0, 62045.68977155085, 62247.37752622416, 62308.376916230256, 640666.7966660137, 645207.0, 648144.0, 649057.0, 651441.0, 27370.86314568494, 27396.493192874583, 27778.166655000383, 27856.582151268154, 28868.42263154767, 37103.81448092742, 37582.62417375791, 50795.74602126966, 52951.20573191482, 54886.72556637191, 41691.58308416877, 42097.0, 42389.78805105955, 42966.71099867009, 43812.0, 42121.0, 42326.36510452407, 42453.787731061144, 42941.35587966246, 43554.782226089934, 40605.0, 40762.0, 41153.55962541296, 41288.174236515704, 43209.0, 33652.831735841166, 35797.82101089478, 36564.45153322649, 36701.81649091737, 36823.63176368202, 26108.8694556526, 26172.8691356542, 26426.0, 26601.0, 26717.465650687267], "value": 21269.33785381685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.64235582086565, 386.9477620521229, 389.48585889540226, 391.45196724585577, 407.6229487723855, 15327.386904523806, 16320.755188672165, 18279.634407311878, 20176.69734953975, 21261.36215913523, 16931.238094285756, 18091.09544522775, 20590.588188236226, 20904.581908361823, 21338.46653833655, 5693.402192769761, 5897.587168898179, 5926.259217597801, 5931.436513531229, 5933.22868027158, 5616.52259557936, 5779.335376431701, 5873.941260587403, 5885.058390657496, 5896.145058966447, 5813.82558523245, 5827.592068555203, 5834.329052158992, 5836.795712150076, 5839.182514447981, 5562.249096371998, 5819.854503637401, 5821.18503409523, 5823.767049318022, 5826.359100498963, 5062.848114556569, 5086.643934924557, 5087.618428617869, 5089.949100508985, 5094.6688465249645, 24851.0, 25905.0, 26099.478010439874, 26121.346966325804, 26301.47397052048, 2440.1093600835743, 2477.095860011101, 2711.9322016949536, 3142.795718278305, 3190.3778763141195, 15146.242687865562, 15718.52844414658, 15876.841231587652, 16258.674826503522, 16534.503964881074, 1775.8934463932205, 1834.2204563060645, 1847.9815201848078, 1862.1620270878025, 1893.2427029188298, 63609.68195158995, 74478.0, 74998.25001749967, 116591.99999999916, 116613.0, 10426.218033647507, 10586.20603454744, 10675.519601617945, 10893.509792059376, 11102.000819926085, 13535.052546321664, 13669.38487768033, 13669.453221871212, 13697.041207115606, 13701.520446784514, 7796.220377962271, 7799.727009554638, 8550.74347769568, 8741.213290803858, 8773.561321933877, 8847.513386763661, 8852.557372131369, 8858.955705221562, 8959.10408959112, 8976.68581599654, 6522.315156908551, 6618.371254730793, 6622.966885165543, 6631.900521492182, 6640.103586015923, 1836.9540761480803, 1872.382113902409, 1875.6342513210066, 1876.6434377468238, 1877.3992322456684, 908.7455512456522, 924.5839372282366, 961.9422834629945, 1011.3503713086486, 1044.9477526123815, 17422.128893555273, 22147.224847130274, 22216.444588885082, 22228.666570001464, 22265.998030088685, 959.194276807485, 992.6823416506649, 999.8750156230471, 1008.1430783833829, 1079.8164312066967, 9555.18780903631, 10238.641647542448, 11789.823152652545, 11878.940605297092, 11966.102542309362, 617957.9102104461, 619204.0, 629111.0, 631185.0, 632200.0, 117833.0, 118588.40705796416, 121679.0, 126488.0, 129488.35255823661, 1043.3426941027105, 1055.4775386184042, 1055.9366438013744, 1071.5499490214129, 1073.7637719701654, 19529.8047019528, 19670.60658786845, 19814.90092549586, 19866.60266794627, 19881.502962426053, 52501.7374913123, 54762.45237547573, 55274.75305184783, 55342.44657553373, 56394.0, 74687.0, 75214.0, 77458.22541774735, 77505.2249477498, 78680.0, 7942.761717148494, 8106.432549721699, 8189.22202390772, 8210.712625058095, 8459.280961118375, 13561.796573051215, 13648.727025459633, 13699.0, 13891.652708682364, 13937.860621393656, 11657.533698652298, 11702.824457633313, 11818.877206665353, 11832.290062596272, 11840.28958262507, 11564.826527601925, 11592.0146787524, 11599.246049006788, 11694.590689325832, 11898.821517677416, 11754.000909922752, 11869.169158158846, 11884.405779711153, 11988.76022479528, 11990.340531270514, 8134.227248411392, 8173.305269051959, 8221.054578723524, 8234.217749313806, 8391.160883911803, 11584.594539191088, 11609.477573509044, 11700.765984680429, 11713.648590542298, 11797.410129493663], "value": 9848.10485674202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.9155850648956, 1552.9145896975665, 1588.4281658602904, 1815.7821061472616, 1959.823615874571, 7739.187385324537, 8179.79550511236, 8189.672413103469, 8196.38527110467, 8774.298056155509, 8274.338052955763, 8773.56132193391, 8986.10138986101, 8990.68532601359, 9015.143561361676, 2373.5608912351186, 2412.6260429633435, 2415.3237093613816, 2415.372003279151, 2418.1657328221736, 2365.3613524348416, 2401.0635852017726, 2407.7712617301418, 2409.4578719787996, 2418.830681852271, 2365.31405892291, 2376.8591076283396, 2391.0196819304088, 2398.95202095958, 2403.2910291463972, 2338.3335749311536, 2375.2755409600063, 2377.049180327883, 2380.27401642499, 2384.332386931662, 2336.0, 2354.3054798834387, 2358.563665721847, 2361.964570531426, 2365.7634236576378, 8997.910020899839, 9008.009118996904, 9082.000979892207, 9086.227670648002, 9114.225290850285, 5243.895122097575, 5249.081410753103, 5424.755885985141, 5425.131978883399, 5434.891302173974, 3003.9399212015855, 3560.3413368526644, 3693.2059607184315, 3708.5178926739623, 3717.7211709121925, 1092.9508172132273, 1104.7735214281054, 1108.5842808946645, 1123.5449642894641, 1125.2404626876908, 11680.824787628193, 11755.23590966593, 11764.941175294154, 11778.705532361673, 11794.646160615195, 4442.355858400579, 4485.932711009337, 4626.352310676508, 4654.022655242369, 4665.206914824488, 9255.305852060988, 9280.72157835266, 9281.67514137002, 9285.07149285066, 9291.814163716823, 5296.4703529647495, 5299.8410047698635, 5305.071612467803, 5313.920291195635, 5319.6808191508635, 4445.422095127613, 4595.862124136282, 4770.42754869411, 4934.506549345037, 4954.5788607968725, 3773.8490460381277, 3783.45139954705, 3866.6326698963553, 3889.4360317753767, 3900.297946369624, 977.9804403911882, 1140.1790710688292, 1145.3700464744356, 1153.8038533449335, 1156.2022204678744, 659.3735950846619, 816.1715858403725, 859.58739804894, 928.6842473559022, 932.8740620016347, 5839.591228613956, 6141.815745527641, 6174.598651087755, 6189.535784816157, 6202.379762023762, 426.22852636727623, 480.22204029472476, 497.7187888842792, 498.81793145502354, 642.293477175113, 3639.9808053744996, 3998.960010399917, 4105.815238314283, 4151.14901445203, 4204.747715137101, 10120.342177758423, 10953.780924381468, 10964.890351096386, 10966.890331096587, 10971.725706857393, 10698.786024279627, 10873.456327183609, 10890.0, 10927.453627318602, 10956.013958743752, 8277.006759188936, 8348.540830254395, 8362.958185209034, 8382.916170838336, 8385.748427547183, 5785.479306862402, 5922.644641321534, 5946.762129514771, 6065.272167339947, 6175.59858609189, 10025.849612255675, 10097.697069087939, 10138.645147419806, 10182.032706892833, 10199.439030853375, 10395.480225988822, 10409.86597747475, 10431.895681043092, 10463.215258855464, 10469.110125639101, 6946.270641582561, 6953.965230173817, 7008.474364422586, 7014.807492660885, 7075.610841403566, 8316.792080198044, 8353.33173346143, 8402.41183117176, 8416.284615807725, 8443.620037098222, 6208.72060757258, 7479.813004674927, 7701.075870895304, 7720.961395192988, 7769.805754856174, 7498.662560184914, 7587.582682952269, 7697.422693298137, 7704.26809453101, 7715.614219289126, 7194.964025179841, 7200.099987501562, 7284.890726639211, 7293.197748247582, 7295.343419092307, 5010.3737032870895, 5167.069927412951, 5168.457311982188, 5241.0, 5265.842024739264, 5190.2214667800135, 5245.790168393221, 5260.105782017143, 5304.124819404909, 5371.033214021513], "value": 4526.800015231397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.7567686374808, 305.46238620028754, 318.21877291249984, 323.91254361322444, 326.19430007880527, 4119.979400102995, 4507.565914406221, 5066.645334826564, 5238.0, 5319.973400132999, 4295.484541854974, 4728.787204575794, 5147.38231412231, 5227.921581176285, 5236.581073514119, 4000.5396681041098, 4019.859304924328, 4025.1748391579654, 4033.1933613277315, 4045.8786236412957, 3495.615482296945, 3746.8455638008118, 4037.3943908413826, 4040.2525532776385, 4042.393640953851, 3587.5694916609914, 3952.7351247600777, 4014.437978682987, 4038.0, 4042.3936409538655, 3431.18147381888, 3898.3762597984187, 3978.542467616218, 3987.9999999999854, 4011.438398624195, 3058.6906885301455, 3358.7648864579487, 3491.94762078569, 3505.6319086495805, 3511.5251594330443, 4436.844710435152, 4711.387519622462, 5013.571132227335, 5088.669236499616, 5140.434552199255, 3858.954753980395, 4481.6638752093395, 4519.457665080178, 4527.253003254459, 4546.340585686201, 4837.080954618611, 5235.612562670895, 5521.944780552183, 5524.779008839641, 5549.528290095347, 3804.2011177652726, 3812.7885826221004, 3814.275287695329, 3821.3759152360412, 3837.1581640812287, 5705.971470142623, 5737.856553586152, 5815.0, 5824.7476792489815, 5836.620619659751, 3851.78815165163, 3861.4940173332425, 3874.0314921269683, 3874.380099184117, 3875.8643447479203, 3128.9361617050313, 3886.203328317688, 3894.6689531389584, 3923.391409522082, 3928.8821335359985, 3797.0, 4530.501644819134, 4531.870021090082, 4541.68208225421, 4557.977210113994, 4155.958440415618, 5344.545713614309, 5473.890522189534, 5575.860603484945, 5582.888342233214, 1202.741410596726, 1248.868868768766, 1294.3398866577925, 1319.327143156997, 1327.4690123950497, 816.5182542299953, 831.8086840026707, 845.9932680110649, 867.9783005424915, 894.7405252476839, 4001.8399264029695, 4396.868093957187, 4466.865994020184, 4513.638908887281, 5032.106538740166, 4818.253170758468, 5024.894523204889, 5413.296271484761, 5568.9721551392795, 5592.245046918695, 4279.3738379416245, 4682.18402002367, 4983.156232194111, 4994.825181118644, 5000.199968005102, 2514.968862766257, 2548.4775620997652, 2812.539028350194, 2991.401719656034, 2991.6559595646345, 4959.801607935642, 5264.947350526446, 5795.449432304009, 5842.065269556851, 5861.413858614104, 4251.553586873396, 5136.614753893473, 5573.491928632132, 5814.302283725895, 5967.134765459071, 5454.318335123855, 5910.8817823643285, 5956.76172953077, 5975.729222895272, 5985.707860676611, 4763.071201115749, 5003.074431230234, 5598.32820061579, 5785.037249484117, 5796.652200867961, 4747.240441529339, 5003.874903127451, 5305.904167853753, 5458.61789674719, 5745.482906538432, 5608.831735047955, 5909.8227053188475, 5925.259342582177, 5930.881382372415, 6101.0, 3142.764292678104, 3241.692039256267, 3771.245750849786, 3832.9233415332096, 3838.673712734449, 5226.059309324358, 5676.290463692038, 5711.257536520226, 5720.369694637008, 5733.770649173986, 5293.062350395414, 5532.474414930575, 5548.140038294071, 5570.415106413769, 5606.719664016864, 4896.36347274852, 5222.843314700565, 5542.196381524737, 5564.91652625219, 5621.353544342453, 5014.749262536786, 5435.0, 5460.208269800777, 5469.234307196916, 5479.0, 5328.706921119376, 5491.368492623399, 5571.3592936811165, 5579.358373787067, 5580.330360356783, 4400.779961002001, 5477.726113694379, 5489.560835133259, 5490.725463726718, 5494.725263736877], "value": 3995.2276766707996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.8195451137215, 785.6464590934078, 804.151620040857, 816.0941355095842, 817.1460823439505, 15280.312385942632, 16473.0, 16486.917565412157, 16487.917560412196, 16553.586160345996, 14611.0, 14845.851541484582, 14878.25608719565, 14906.180160091191, 14945.40218391263, 716.323074694414, 742.7660287009575, 743.0266351080076, 744.1776836595538, 746.4998451037791, 727.240034164297, 733.8312188196718, 921.8064206516606, 924.5146298193436, 928.5914197752967, 951.4529145741192, 970.5923512124889, 971.2569884038716, 971.3152227679504, 972.9659461918834, 958.4153666263574, 961.20700422152, 961.6441916490874, 962.2206013129388, 963.903609639034, 563.6871536297353, 695.523566357042, 722.1911459165768, 724.7825652304288, 725.3725527418745, 14412.927935360256, 14440.0, 14452.349644266033, 14464.421423143061, 14498.710025799424, 11983.88016119845, 13990.790138147935, 14491.058081224792, 14556.344964476624, 14778.334974926154, 11332.376719280437, 11886.821697674455, 11912.702182445422, 12151.0, 12217.144799864012, 4714.929276060861, 4715.622750180011, 4750.263709125091, 4754.714717116949, 4945.727984960826, 109717.9999999992, 112840.0, 113709.86290137075, 114881.0, 116426.25360619597, 11209.55161793519, 11596.01433878113, 11842.88157118435, 11922.225055371373, 11945.283283003047, 23006.0, 23414.297571072893, 23467.295981120595, 23485.882570587037, 23576.58139569753, 8125.0, 8170.428070035159, 8341.624626891804, 8460.492370457792, 8486.618102185417, 4358.978205108954, 4443.466783985942, 4479.260921947907, 4488.371627972087, 4647.1635105680625, 3536.1159710072484, 3626.3472574936764, 3667.339878821838, 3668.963310366862, 3676.191237927652, 673.0476375928105, 677.1941389746187, 678.8235058884726, 679.7954650486755, 680.9625470599066, 595.2707932782394, 603.3212635784743, 657.1850904878013, 659.9342062568917, 666.2271764752863, 8687.391882568287, 8723.582765314188, 9043.547822608843, 9058.773530661654, 9192.369014239339, 556.6576555418388, 607.1924340626956, 665.8813193834404, 672.3175976383974, 675.2673349415841, 3799.411091280856, 4258.978705106455, 4357.564243575617, 4374.409454723572, 4478.94744734987, 144700.27649861682, 146619.53380466058, 147793.0, 147927.26036369964, 152668.20649728522, 123506.0, 123697.0, 124538.0, 126988.0, 127716.0, 104945.47527262468, 106144.0, 107376.92623073826, 107517.46241268744, 110197.44901275603, 8392.916070839214, 8836.0, 8867.778305542413, 9218.585163667785, 9317.254619630548, 47516.762416187696, 50197.0, 55455.445445545025, 58004.0, 62210.0, 95437.52281238549, 96156.78824088081, 97094.0, 98113.50943245238, 99455.0, 13766.793006965047, 13863.861361386256, 13914.373853176834, 13926.651833703832, 14244.786328204878, 14089.718205636034, 14213.50252741149, 14253.328428106799, 14649.0, 14812.851871481578, 12658.11393202467, 12895.16181448203, 13012.544560940321, 13012.804807928078, 13276.668083297995, 11408.315501069963, 12572.937135314265, 12647.0, 12886.355682215664, 13093.476260949456, 13003.08978371505, 13037.936871452526, 13046.412911419198, 13152.369526094628, 13619.795703064265, 10404.167666586807, 10426.739331516772, 10482.423466709404, 10545.52545135486, 10790.67627971162, 7418.629068546659, 9879.456629885426, 10795.6221532246, 10938.781224375627, 10994.725131871448], "value": 7851.268186574191, "unit": "score"}], "name": "dromaeo_css", "value": 7466.234578611738, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 112.0, 114.0, 112.0, 111.0, 112.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 107.0, 106.0, 160.0, 125.0, 137.0, 130.0, 106.0, 160.0, 107.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 184.0, 184.0, 185.0, 182.0, 180.0, 200.0, 184.0, 183.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 58.0, 107.0, 59.0, 58.0, 76.0, 84.0, 111.0, 62.0], "value": 76.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 92.0, 70.0, 70.0, 68.0, 96.0, 70.0, 67.0, 100.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 84.0, 86.0, 85.0, 87.0, 84.0, 86.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 93.0, 98.0, 93.0, 94.0, 93.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 91.0, 90.0, 90.0, 90.0, 90.0, 87.0, 91.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 55.0, 57.0, 56.0, 56.0, 55.0, 54.0, 51.0, 61.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 75.0, 71.0, 72.0, 73.0, 71.0, 73.0, 71.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 86.0, 73.0, 91.0, 91.0, 91.0, 84.0, 85.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 131.0, 136.0, 145.0, 139.0, 136.0, 137.0, 231.0, 155.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 160.0, 167.0, 165.0, 209.0, 221.0, 175.0, 160.0, 219.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 80.0, 83.0, 75.0, 66.0, 65.0, 64.0, 64.0, 65.0, 66.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1459.0999999999997, "alertThreshold": 2.0}]} 22:15:06 INFO - Return code: 0 22:15:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:15:06 INFO - # TBPL SUCCESS # 22:15:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:15:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:15:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:15:06 INFO - 2016-07-04 22:15:06.617 screenresolution[1674:10085] starting screenresolution argv=screenresolution get 22:15:06 INFO - 2016-07-04 22:15:06.620 screenresolution[1674:10085] Display 0: 1600x1200x32@60 22:15:06 INFO - 2016-07-04 22:15:06.625 screenresolution[1675:10088] starting screenresolution argv=screenresolution list 22:15:06 INFO - Available Modes on Display 0 22:15:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:15:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:15:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:15:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:15:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:15:06 INFO - Intel Iris: 22:15:06 INFO - Chipset Model: Intel Iris 22:15:06 INFO - Type: GPU 22:15:06 INFO - Bus: Built-In 22:15:06 INFO - VRAM (Dynamic, Max): 1536 MB 22:15:06 INFO - Vendor: Intel (0x8086) 22:15:06 INFO - Device ID: 0x0a2e 22:15:06 INFO - Revision ID: 0x0009 22:15:06 INFO - Displays: 22:15:06 INFO - Display: 22:15:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:15:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:15:06 INFO - Display Serial Number: 1600x1200 60 22:15:06 INFO - Main Display: Yes 22:15:06 INFO - Mirror: Off 22:15:06 INFO - Online: Yes 22:15:06 INFO - Rotation: Supported 22:15:06 INFO - Return code: 0 22:15:06 INFO - Running post-action listener: _resource_record_post_action 22:15:06 INFO - ##### 22:15:06 INFO - ##### Finished run-tests step (success) 22:15:06 INFO - ##### 22:15:06 INFO - Running post-run listener: _resource_record_post_run 22:15:06 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 31395328; Write bytes: 708103680; Read time: 192; Write time: 1973 22:15:06 INFO - TinderboxPrint: CPU usage
53.4% 22:15:06 INFO - TinderboxPrint: I/O read bytes / time
31,395,328 / 192 22:15:06 INFO - TinderboxPrint: I/O write bytes / time
708,103,680 / 1,973 22:15:06 INFO - TinderboxPrint: CPU idle
2,258.3 (46.6%) 22:15:06 INFO - TinderboxPrint: CPU system
964.9 (19.9%) 22:15:06 INFO - TinderboxPrint: CPU user
1,622.5 (33.5%) 22:15:06 INFO - TinderboxPrint: Swap in / out
434,397,184 / 0 22:15:06 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385999360; Write bytes: 382519296; Read time: 28722; Write time: 818 22:15:06 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30481920; Write bytes: 296068608; Read time: 182; Write time: 1086 22:15:07 INFO - Running post-run listener: _upload_blobber_files 22:15:07 INFO - Blob upload gear active. 22:15:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:15:07 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 22:15:07 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'] 22:15:07 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 22:15:07 INFO - (blobuploader) - INFO - Open directory for files ... 22:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:08 INFO - (blobuploader) - INFO - Done attempting. 22:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:09 INFO - (blobuploader) - INFO - Done attempting. 22:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:12 INFO - (blobuploader) - INFO - Done attempting. 22:15:12 INFO - (blobuploader) - INFO - Iteration through files over. 22:15:12 INFO - Return code: 0 22:15:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:15:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:15:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b357d41016b4b3727d3b54e2eb4e9c2c41548c3bcd62d011ac3a0c34d2956ce9d2303bba76aa6ab596602904ad57e4b2835989fd738c7a643e892d0deeab239", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf8810cf6bba24bab3b553149118c38e98e0aa4a842ae87df3c2e5006edb5a900ba06174b3bff451a48ed7625aed0f6bc8c96e45fab92215a46a2dea9071c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057de71172ada91c0898fffd6cdae3377fc3c1cfee330b269fb90986c67c34eaebe2f8a66ef3ad35e0dc3677dfc0e82a289a87f7523e8a74843b5028f1d6410f"} 22:15:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:15:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:15:12 INFO - Contents: 22:15:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b357d41016b4b3727d3b54e2eb4e9c2c41548c3bcd62d011ac3a0c34d2956ce9d2303bba76aa6ab596602904ad57e4b2835989fd738c7a643e892d0deeab239", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf8810cf6bba24bab3b553149118c38e98e0aa4a842ae87df3c2e5006edb5a900ba06174b3bff451a48ed7625aed0f6bc8c96e45fab92215a46a2dea9071c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057de71172ada91c0898fffd6cdae3377fc3c1cfee330b269fb90986c67c34eaebe2f8a66ef3ad35e0dc3677dfc0e82a289a87f7523e8a74843b5028f1d6410f"} 22:15:12 INFO - Running post-run listener: copy_logs_to_upload_dir 22:15:12 INFO - Copying logs to upload dir... 22:15:12 INFO - mkdir: /builds/slave/test/build/upload/logs 22:15:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.755531 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-04 22:15:12.142600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 22:15:12.155305) ========= 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.AbI8kGJkXj/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.2YcV0gY84v/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/2b357d41016b4b3727d3b54e2eb4e9c2c41548c3bcd62d011ac3a0c34d2956ce9d2303bba76aa6ab596602904ad57e4b2835989fd738c7a643e892d0deeab239", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf8810cf6bba24bab3b553149118c38e98e0aa4a842ae87df3c2e5006edb5a900ba06174b3bff451a48ed7625aed0f6bc8c96e45fab92215a46a2dea9071c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057de71172ada91c0898fffd6cdae3377fc3c1cfee330b269fb90986c67c34eaebe2f8a66ef3ad35e0dc3677dfc0e82a289a87f7523e8a74843b5028f1d6410f"} build_url:https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/ZjaQ8DfUQa2AChH28p3lew/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/2b357d41016b4b3727d3b54e2eb4e9c2c41548c3bcd62d011ac3a0c34d2956ce9d2303bba76aa6ab596602904ad57e4b2835989fd738c7a643e892d0deeab239", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf8810cf6bba24bab3b553149118c38e98e0aa4a842ae87df3c2e5006edb5a900ba06174b3bff451a48ed7625aed0f6bc8c96e45fab92215a46a2dea9071c7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057de71172ada91c0898fffd6cdae3377fc3c1cfee330b269fb90986c67c34eaebe2f8a66ef3ad35e0dc3677dfc0e82a289a87f7523e8a74843b5028f1d6410f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 22:15:12.187693) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:15:12.191038) ========= 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.AbI8kGJkXj/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.2YcV0gY84v/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005147 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:15:12.239479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 22:15:12.240843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 22:15:12.241166) ========= ========= Total master_lag: 0.19 =========