builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1467829091.33 results: success (0) buildid: 20160706083048 builduid: bdf4035ff9fa445a9fdb7c56bb78a699 revision: 3705eb1dc2cce4582cc3f95af52aeec700801fae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.332647) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.333107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.333419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.348450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.348837) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467828731.204701-737714826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 11:18:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (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% 46.3M=0s 2016-07-06 11:18:12 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.368210 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.732003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.732314) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467828731.204701-737714826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014211 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.783468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:11.783925) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3705eb1dc2cce4582cc3f95af52aeec700801fae --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 3705eb1dc2cce4582cc3f95af52aeec700801fae --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467828731.204701-737714826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 11:18:13,066 truncating revision to first 12 chars 2016-07-06 11:18:13,066 Setting DEBUG logging. 2016-07-06 11:18:13,066 attempt 1/10 2016-07-06 11:18:13,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3705eb1dc2cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 11:18:13,371 unpacking tar archive at: fx-team-3705eb1dc2cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:12.502664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:12.502964) ========= script_repo_revision: 3705eb1dc2cce4582cc3f95af52aeec700801fae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:12.503349) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:12.503664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 11:18:12.512571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-06 11:18:12.512921) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467828731.204701-737714826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:13 INFO - MultiFileLogger online at 20160706 11:18:13 in /builds/slave/test 11:18:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:18:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:13 INFO - {'append_to_log': False, 11:18:13 INFO - 'base_work_dir': '/builds/slave/test', 11:18:13 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:13 INFO - 'branch': 'Fx-Team', 11:18:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:13 INFO - 'config_files': ('talos/linux_config.py',), 11:18:13 INFO - 'default_actions': ('clobber', 11:18:13 INFO - 'read-buildbot-config', 11:18:13 INFO - 'download-and-extract', 11:18:13 INFO - 'populate-webroot', 11:18:13 INFO - 'create-virtualenv', 11:18:13 INFO - 'install', 11:18:13 INFO - 'run-tests'), 11:18:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:13 INFO - 'download_minidump_stackwalk': True, 11:18:13 INFO - 'download_symbols': 'ondemand', 11:18:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:13 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:13 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:13 INFO - 'installer_path': 'installer.exe', 11:18:13 INFO - 'log_level': 'info', 11:18:13 INFO - 'log_name': 'talos', 11:18:13 INFO - 'log_to_console': True, 11:18:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:13 INFO - 'opt_config_files': (), 11:18:13 INFO - 'pip_index': False, 11:18:13 INFO - 'sps_profile': False, 11:18:13 INFO - 'sps_profile_interval': 0, 11:18:13 INFO - 'suite': 'dromaeojs-e10s', 11:18:13 INFO - 'system_bits': '32', 11:18:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:13 INFO - 'title': 'talos-linux64-ix-056', 11:18:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:13 INFO - 'use_talos_json': True, 11:18:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:13 INFO - 'work_dir': 'build'} 11:18:13 INFO - ##### 11:18:13 INFO - ##### Running clobber step. 11:18:13 INFO - ##### 11:18:13 INFO - Running pre-action listener: _resource_record_pre_action 11:18:13 INFO - Running main action method: clobber 11:18:13 INFO - rmtree: /builds/slave/test/build 11:18:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:14 INFO - Running post-action listener: _resource_record_post_action 11:18:14 INFO - ##### 11:18:14 INFO - ##### Finished clobber step (success) 11:18:14 INFO - ##### 11:18:14 INFO - ##### 11:18:14 INFO - ##### Running read-buildbot-config step. 11:18:14 INFO - ##### 11:18:14 INFO - Running pre-action listener: _resource_record_pre_action 11:18:14 INFO - Running main action method: read_buildbot_config 11:18:14 INFO - Using buildbot properties: 11:18:14 INFO - { 11:18:14 INFO - "project": "", 11:18:14 INFO - "product": "firefox", 11:18:14 INFO - "script_repo_revision": "production", 11:18:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:18:14 INFO - "repository": "", 11:18:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:18:14 INFO - "buildid": "20160706083048", 11:18:14 INFO - "pgo_build": "True", 11:18:14 INFO - "basedir": "/builds/slave/test", 11:18:14 INFO - "buildnumber": 542, 11:18:14 INFO - "slavename": "talos-linux64-ix-056", 11:18:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:18:14 INFO - "platform": "ubuntu64_hw", 11:18:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:18:14 INFO - "branch": "fx-team", 11:18:14 INFO - "repo_path": "integration/fx-team", 11:18:14 INFO - "revision": "3705eb1dc2cce4582cc3f95af52aeec700801fae", 11:18:14 INFO - "stage_platform": "linux64-pgo", 11:18:14 INFO - "builduid": "bdf4035ff9fa445a9fdb7c56bb78a699", 11:18:14 INFO - "slavebuilddir": "test" 11:18:14 INFO - } 11:18:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:18:14 INFO - Running post-action listener: _resource_record_post_action 11:18:14 INFO - ##### 11:18:14 INFO - ##### Finished read-buildbot-config step (success) 11:18:14 INFO - ##### 11:18:14 INFO - ##### 11:18:14 INFO - ##### Running download-and-extract step. 11:18:14 INFO - ##### 11:18:14 INFO - Running pre-action listener: _resource_record_pre_action 11:18:14 INFO - Running main action method: download_and_extract 11:18:14 INFO - mkdir: /builds/slave/test/build/tests 11:18:14 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')]} 11:18:14 INFO - https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:18:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:18:15 INFO - Downloaded 1361 bytes. 11:18:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:15 INFO - Using the following test package requirements: 11:18:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:18:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'jsshell-linux-x86_64.zip'], 11:18:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:18:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:18:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18:15 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')]} 11:18:15 INFO - https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:24 INFO - Downloaded 24300790 bytes. 11:18:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:18:25 INFO - Return code: 0 11:18:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:25 INFO - https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:39 INFO - Downloaded 24300790 bytes. 11:18:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:18:41 INFO - Return code: 0 11:18:41 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')]} 11:18:41 INFO - https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:18:42 INFO - Downloaded 14403333 bytes. 11:18:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:18:42 INFO - Return code: 0 11:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:18:42 INFO - https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:18:44 INFO - Downloaded 60354559 bytes. 11:18:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:44 INFO - mkdir: /builds/slave/test/properties 11:18:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:44 INFO - Contents: 11:18:44 INFO - build_url:https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:45 INFO - Running post-action listener: _resource_record_post_action 11:18:45 INFO - Running post-action listener: set_extra_try_arguments 11:18:45 INFO - ##### 11:18:45 INFO - ##### Finished download-and-extract step (success) 11:18:45 INFO - ##### 11:18:45 INFO - ##### 11:18:45 INFO - ##### Running populate-webroot step. 11:18:45 INFO - ##### 11:18:45 INFO - Running pre-action listener: _resource_record_pre_action 11:18:45 INFO - Running main action method: populate_webroot 11:18:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:45 INFO - '--tppagecycles', 11:18:45 INFO - '7'], 11:18:45 INFO - 'tests': ['tsvgm']}}, 11:18:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['damp', 'tps']}, 11:18:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'tests': ['damp', 'tps']}, 11:18:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['dromaeo_dom']}, 11:18:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['basic_compositor_video']}, 11:18:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['a11yr', 11:18:45 INFO - 'ts_paint', 11:18:45 INFO - 'tpaint', 11:18:45 INFO - 'sessionrestore', 11:18:45 INFO - 'sessionrestore_no_auto_restore', 11:18:45 INFO - 'tabpaint']}, 11:18:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:45 INFO - 'ts_paint', 11:18:45 INFO - 'tpaint', 11:18:45 INFO - 'sessionrestore', 11:18:45 INFO - 'sessionrestore_no_auto_restore', 11:18:45 INFO - 'tabpaint']}, 11:18:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:45 INFO - 'ts_paint', 11:18:45 INFO - 'tpaint', 11:18:45 INFO - 'sessionrestore', 11:18:45 INFO - 'sessionrestore_no_auto_restore', 11:18:45 INFO - 'tabpaint']}, 11:18:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:45 INFO - 'ts_paint', 11:18:45 INFO - 'tpaint', 11:18:45 INFO - 'sessionrestore', 11:18:45 INFO - 'sessionrestore_no_auto_restore', 11:18:45 INFO - 'tabpaint']}, 11:18:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['a11yr', 11:18:45 INFO - 'ts_paint', 11:18:45 INFO - 'tpaint', 11:18:45 INFO - 'sessionrestore', 11:18:45 INFO - 'sessionrestore_no_auto_restore', 11:18:45 INFO - 'tabpaint']}, 11:18:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['a11yr', 11:18:45 INFO - 'ts_paint', 11:18:45 INFO - 'tpaint', 11:18:45 INFO - 'sessionrestore', 11:18:45 INFO - 'sessionrestore_no_auto_restore', 11:18:45 INFO - 'tabpaint']}, 11:18:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['tsvgx', 11:18:45 INFO - 'tsvgr_opacity', 11:18:45 INFO - 'tart', 11:18:45 INFO - 'tscrollx', 11:18:45 INFO - 'cart']}, 11:18:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:45 INFO - 'tsvgr_opacity', 11:18:45 INFO - 'tart', 11:18:45 INFO - 'tscrollx', 11:18:45 INFO - 'cart']}, 11:18:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'talos_options': ['--disable-e10s'], 11:18:45 INFO - 'tests': ['tp5o']}, 11:18:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'tests': ['tp5o']}, 11:18:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'talos_options': ['--disable-e10s', 11:18:45 INFO - '--xperf_path', 11:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:45 INFO - 'tests': ['tp5n']}, 11:18:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:45 INFO - 'talos_options': ['--xperf_path', 11:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:45 INFO - 'tests': ['tp5n']}}, 11:18:45 INFO - 'talos.zip': {'path': '', 11:18:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:45 INFO - Running post-action listener: _resource_record_post_action 11:18:45 INFO - ##### 11:18:45 INFO - ##### Finished populate-webroot step (success) 11:18:45 INFO - ##### 11:18:45 INFO - ##### 11:18:45 INFO - ##### Running create-virtualenv step. 11:18:45 INFO - ##### 11:18:45 INFO - Running pre-action listener: _resource_record_pre_action 11:18:45 INFO - Running main action method: create_virtualenv 11:18:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:45 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 11:18:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:45 INFO - Using real prefix '/usr' 11:18:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:47 INFO - Installing pip.................done. 11:18:47 INFO - Return code: 0 11:18:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:47 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')]} 11:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 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')]} 11:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:47 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 11:18:47 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 11:18:47 INFO - Using env: {'DISPLAY': ':0', 11:18:47 INFO - 'HOME': '/home/cltbld', 11:18:47 INFO - 'LANG': 'en_US.UTF-8', 11:18:47 INFO - 'LANGUAGE': 'en_US:en', 11:18:47 INFO - 'LOGNAME': 'cltbld', 11:18:47 INFO - 'MAIL': '/var/mail/cltbld', 11:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:47 INFO - 'MOZ_NO_REMOTE': '1', 11:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:47 INFO - 'NO_EM_RESTART': '1', 11:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:47 INFO - 'PWD': '/builds/slave/test', 11:18:47 INFO - 'SHELL': '/bin/bash', 11:18:47 INFO - 'SHLVL': '1', 11:18:47 INFO - 'TERM': 'linux', 11:18:47 INFO - 'TMOUT': '86400', 11:18:47 INFO - 'USER': 'cltbld', 11:18:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:47 INFO - '_': '/tools/buildbot/bin/python'} 11:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:48 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 11:18:48 INFO - Cleaning up... 11:18:48 INFO - Return code: 0 11:18:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:18:48 INFO - Using env: {'DISPLAY': ':0', 11:18:48 INFO - 'HOME': '/home/cltbld', 11:18:48 INFO - 'LANG': 'en_US.UTF-8', 11:18:48 INFO - 'LANGUAGE': 'en_US:en', 11:18:48 INFO - 'LOGNAME': 'cltbld', 11:18:48 INFO - 'MAIL': '/var/mail/cltbld', 11:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:48 INFO - 'MOZ_NO_REMOTE': '1', 11:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:48 INFO - 'NO_EM_RESTART': '1', 11:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:48 INFO - 'PWD': '/builds/slave/test', 11:18:48 INFO - 'SHELL': '/bin/bash', 11:18:48 INFO - 'SHLVL': '1', 11:18:48 INFO - 'TERM': 'linux', 11:18:48 INFO - 'TMOUT': '86400', 11:18:48 INFO - 'USER': 'cltbld', 11:18:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:48 INFO - '_': '/tools/buildbot/bin/python'} 11:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:48 INFO - Downloading/unpacking psutil>=3.1.1 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:50 INFO - Installing collected packages: psutil 11:18:50 INFO - Running setup.py install for psutil 11:18:50 INFO - building 'psutil._psutil_linux' extension 11:18:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:18:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:18:50 INFO - building 'psutil._psutil_posix' extension 11:18:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:18:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:18:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:50 INFO - Successfully installed psutil 11:18:50 INFO - Cleaning up... 11:18:50 INFO - Return code: 0 11:18:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:50 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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:50 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 11:18:50 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 11:18:50 INFO - Using env: {'DISPLAY': ':0', 11:18:50 INFO - 'HOME': '/home/cltbld', 11:18:50 INFO - 'LANG': 'en_US.UTF-8', 11:18:50 INFO - 'LANGUAGE': 'en_US:en', 11:18:50 INFO - 'LOGNAME': 'cltbld', 11:18:50 INFO - 'MAIL': '/var/mail/cltbld', 11:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:50 INFO - 'MOZ_NO_REMOTE': '1', 11:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:50 INFO - 'NO_EM_RESTART': '1', 11:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:50 INFO - 'PWD': '/builds/slave/test', 11:18:50 INFO - 'SHELL': '/bin/bash', 11:18:50 INFO - 'SHLVL': '1', 11:18:50 INFO - 'TERM': 'linux', 11:18:50 INFO - 'TMOUT': '86400', 11:18:50 INFO - 'USER': 'cltbld', 11:18:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:50 INFO - '_': '/tools/buildbot/bin/python'} 11:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:52 INFO - Installing collected packages: mozsystemmonitor 11:18:52 INFO - Running setup.py install for mozsystemmonitor 11:18:53 INFO - Successfully installed mozsystemmonitor 11:18:53 INFO - Cleaning up... 11:18:53 INFO - Return code: 0 11:18:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:53 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')]} 11:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:53 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')]} 11:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:53 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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:53 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 11:18:53 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 11:18:53 INFO - Using env: {'DISPLAY': ':0', 11:18:53 INFO - 'HOME': '/home/cltbld', 11:18:53 INFO - 'LANG': 'en_US.UTF-8', 11:18:53 INFO - 'LANGUAGE': 'en_US:en', 11:18:53 INFO - 'LOGNAME': 'cltbld', 11:18:53 INFO - 'MAIL': '/var/mail/cltbld', 11:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:53 INFO - 'MOZ_NO_REMOTE': '1', 11:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:53 INFO - 'NO_EM_RESTART': '1', 11:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:53 INFO - 'PWD': '/builds/slave/test', 11:18:53 INFO - 'SHELL': '/bin/bash', 11:18:53 INFO - 'SHLVL': '1', 11:18:53 INFO - 'TERM': 'linux', 11:18:53 INFO - 'TMOUT': '86400', 11:18:53 INFO - 'USER': 'cltbld', 11:18:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:53 INFO - '_': '/tools/buildbot/bin/python'} 11:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:53 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 11:18:53 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 11:18:53 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 11:18:53 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 11:18:53 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 11:18:53 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 11:18:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:55 INFO - warning: no files found matching '*.txt' 11:18:55 INFO - no previously-included directories found matching 'build' 11:18:55 INFO - no previously-included directories found matching 'dist' 11:18:55 INFO - no previously-included directories found matching '.git*' 11:18:55 INFO - Installing collected packages: jsonschema, functools32 11:18:55 INFO - Running setup.py install for functools32 11:18:55 INFO - warning: no files found matching '*.txt' 11:18:55 INFO - no previously-included directories found matching 'build' 11:18:55 INFO - no previously-included directories found matching 'dist' 11:18:55 INFO - no previously-included directories found matching '.git*' 11:18:55 INFO - Successfully installed jsonschema functools32 11:18:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:18:55 INFO - Using env: {'DISPLAY': ':0', 11:18:55 INFO - 'HOME': '/home/cltbld', 11:18:55 INFO - 'LANG': 'en_US.UTF-8', 11:18:55 INFO - 'LANGUAGE': 'en_US:en', 11:18:55 INFO - 'LOGNAME': 'cltbld', 11:18:55 INFO - 'MAIL': '/var/mail/cltbld', 11:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:55 INFO - 'MOZ_NO_REMOTE': '1', 11:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:55 INFO - 'NO_EM_RESTART': '1', 11:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:55 INFO - 'PWD': '/builds/slave/test', 11:18:55 INFO - 'SHELL': '/bin/bash', 11:18:55 INFO - 'SHLVL': '1', 11:18:55 INFO - 'TERM': 'linux', 11:18:55 INFO - 'TMOUT': '86400', 11:18:55 INFO - 'USER': 'cltbld', 11:18:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:55 INFO - '_': '/tools/buildbot/bin/python'} 11:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - Downloading docopt-0.6.1.tar.gz 11:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:58 INFO - Running setup.py install for blobuploader 11:18:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:58 INFO - Running setup.py install for requests 11:18:59 INFO - Running setup.py install for docopt 11:18:59 INFO - Successfully installed blobuploader requests docopt 11:18:59 INFO - Cleaning up... 11:18:59 INFO - Return code: 0 11:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:59 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')]} 11:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 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')]} 11:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:59 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 11:18:59 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 11:18:59 INFO - Using env: {'DISPLAY': ':0', 11:18:59 INFO - 'HOME': '/home/cltbld', 11:18:59 INFO - 'LANG': 'en_US.UTF-8', 11:18:59 INFO - 'LANGUAGE': 'en_US:en', 11:18:59 INFO - 'LOGNAME': 'cltbld', 11:18:59 INFO - 'MAIL': '/var/mail/cltbld', 11:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:59 INFO - 'MOZ_NO_REMOTE': '1', 11:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:59 INFO - 'NO_EM_RESTART': '1', 11:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:59 INFO - 'PWD': '/builds/slave/test', 11:18:59 INFO - 'SHELL': '/bin/bash', 11:18:59 INFO - 'SHLVL': '1', 11:18:59 INFO - 'TERM': 'linux', 11:18:59 INFO - 'TMOUT': '86400', 11:18:59 INFO - 'USER': 'cltbld', 11:18:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:59 INFO - '_': '/tools/buildbot/bin/python'} 11:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:59 INFO - Running setup.py (path:/tmp/pip-pruVqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:59 INFO - Running setup.py (path:/tmp/pip-RXujFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:59 INFO - Running setup.py (path:/tmp/pip-eeKJw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:59 INFO - Running setup.py (path:/tmp/pip-XoeXSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:59 INFO - Running setup.py (path:/tmp/pip-UDlD2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:59 INFO - Running setup.py (path:/tmp/pip-4OX4zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:59 INFO - Running setup.py (path:/tmp/pip-nhyoog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:59 INFO - Running setup.py (path:/tmp/pip-jOH7Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:59 INFO - Running setup.py (path:/tmp/pip-cTM_5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:00 INFO - Running setup.py (path:/tmp/pip-TqDC2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:00 INFO - Running setup.py (path:/tmp/pip-Y6f8rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:00 INFO - Running setup.py (path:/tmp/pip-0u7yVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:00 INFO - Running setup.py (path:/tmp/pip-6ydCY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:00 INFO - Running setup.py (path:/tmp/pip-CJPmwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:00 INFO - Running setup.py (path:/tmp/pip-Gn99eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:00 INFO - Running setup.py (path:/tmp/pip-Cu6JJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:00 INFO - Running setup.py (path:/tmp/pip-67bLWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:19:00 INFO - Running setup.py install for manifestparser 11:19:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:19:00 INFO - Running setup.py install for mozcrash 11:19:00 INFO - Running setup.py install for mozdebug 11:19:00 INFO - Running setup.py install for mozdevice 11:19:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Running setup.py install for mozfile 11:19:01 INFO - Running setup.py install for mozhttpd 11:19:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Running setup.py install for mozinfo 11:19:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Running setup.py install for mozInstall 11:19:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Running setup.py install for mozleak 11:19:01 INFO - Running setup.py install for mozlog 11:19:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Running setup.py install for moznetwork 11:19:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Running setup.py install for mozprocess 11:19:01 INFO - Running setup.py install for mozprofile 11:19:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:19:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:19:02 INFO - Running setup.py install for mozrunner 11:19:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:19:02 INFO - Running setup.py install for mozscreenshot 11:19:02 INFO - Running setup.py install for moztest 11:19:02 INFO - Running setup.py install for mozversion 11:19:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:19:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:19:02 INFO - Cleaning up... 11:19:02 INFO - Return code: 0 11:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:02 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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:02 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 11:19:02 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 11:19:02 INFO - Using env: {'DISPLAY': ':0', 11:19:02 INFO - 'HOME': '/home/cltbld', 11:19:02 INFO - 'LANG': 'en_US.UTF-8', 11:19:02 INFO - 'LANGUAGE': 'en_US:en', 11:19:02 INFO - 'LOGNAME': 'cltbld', 11:19:02 INFO - 'MAIL': '/var/mail/cltbld', 11:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:02 INFO - 'MOZ_NO_REMOTE': '1', 11:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:02 INFO - 'NO_EM_RESTART': '1', 11:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:02 INFO - 'PWD': '/builds/slave/test', 11:19:02 INFO - 'SHELL': '/bin/bash', 11:19:02 INFO - 'SHLVL': '1', 11:19:02 INFO - 'TERM': 'linux', 11:19:02 INFO - 'TMOUT': '86400', 11:19:02 INFO - 'USER': 'cltbld', 11:19:02 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:02 INFO - '_': '/tools/buildbot/bin/python'} 11:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:02 INFO - Running setup.py (path:/tmp/pip-F_MH72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:02 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)) 11:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:02 INFO - Running setup.py (path:/tmp/pip-7R0B4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:02 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)) 11:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:02 INFO - Running setup.py (path:/tmp/pip-Hzcqiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:02 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)) 11:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:02 INFO - Running setup.py (path:/tmp/pip-Mf3AeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:02 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)) 11:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:02 INFO - Running setup.py (path:/tmp/pip-e6vqC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:03 INFO - Running setup.py (path:/tmp/pip-J8ufnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:03 INFO - Running setup.py (path:/tmp/pip-ZulgkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:03 INFO - Running setup.py (path:/tmp/pip-z3qA01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:03 INFO - Running setup.py (path:/tmp/pip-Ll36pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:03 INFO - Running setup.py (path:/tmp/pip-eFYD8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:03 INFO - Running setup.py (path:/tmp/pip-guEgaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:03 INFO - Running setup.py (path:/tmp/pip-8W1GyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:03 INFO - Running setup.py (path:/tmp/pip-yTb29p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:03 INFO - Running setup.py (path:/tmp/pip-V91dng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:03 INFO - Running setup.py (path:/tmp/pip-pxT2YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:03 INFO - Running setup.py (path:/tmp/pip-ub_vf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:03 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)) 11:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:03 INFO - Running setup.py (path:/tmp/pip-ldpJVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:03 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 11:19:03 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 11:19:03 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 11:19:03 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 11:19:03 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 11:19:03 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 11:19:05 INFO - Downloading blessings-1.6.tar.gz 11:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:05 INFO - Installing collected packages: blessings 11:19:05 INFO - Running setup.py install for blessings 11:19:05 INFO - Successfully installed blessings 11:19:05 INFO - Cleaning up... 11:19:06 INFO - Return code: 0 11:19:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:06 INFO - Reading from file tmpfile_stdout 11:19:06 INFO - Current package versions: 11:19:06 INFO - argparse == 1.2.1 11:19:06 INFO - blessings == 1.6 11:19:06 INFO - blobuploader == 1.2.4 11:19:06 INFO - docopt == 0.6.1 11:19:06 INFO - functools32 == 3.2.3-2 11:19:06 INFO - jsonschema == 2.5.1 11:19:06 INFO - manifestparser == 1.1 11:19:06 INFO - mozInstall == 1.12 11:19:06 INFO - mozcrash == 0.17 11:19:06 INFO - mozdebug == 0.1 11:19:06 INFO - mozdevice == 0.48 11:19:06 INFO - mozfile == 1.2 11:19:06 INFO - mozhttpd == 0.7 11:19:06 INFO - mozinfo == 0.9 11:19:06 INFO - mozleak == 0.1 11:19:06 INFO - mozlog == 3.2 11:19:06 INFO - moznetwork == 0.27 11:19:06 INFO - mozprocess == 0.22 11:19:06 INFO - mozprofile == 0.28 11:19:06 INFO - mozrunner == 6.11 11:19:06 INFO - mozscreenshot == 0.1 11:19:06 INFO - mozsystemmonitor == 0.3 11:19:06 INFO - moztest == 0.7 11:19:06 INFO - mozversion == 1.4 11:19:06 INFO - psutil == 3.1.1 11:19:06 INFO - requests == 1.2.3 11:19:06 INFO - wsgiref == 0.1.2 11:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:06 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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:06 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 11:19:06 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 11:19:06 INFO - Using env: {'DISPLAY': ':0', 11:19:06 INFO - 'HOME': '/home/cltbld', 11:19:06 INFO - 'LANG': 'en_US.UTF-8', 11:19:06 INFO - 'LANGUAGE': 'en_US:en', 11:19:06 INFO - 'LOGNAME': 'cltbld', 11:19:06 INFO - 'MAIL': '/var/mail/cltbld', 11:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:06 INFO - 'MOZ_NO_REMOTE': '1', 11:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:06 INFO - 'NO_EM_RESTART': '1', 11:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:06 INFO - 'PWD': '/builds/slave/test', 11:19:06 INFO - 'SHELL': '/bin/bash', 11:19:06 INFO - 'SHLVL': '1', 11:19:06 INFO - 'TERM': 'linux', 11:19:06 INFO - 'TMOUT': '86400', 11:19:06 INFO - 'USER': 'cltbld', 11:19:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:06 INFO - '_': '/tools/buildbot/bin/python'} 11:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 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)) 11:19:06 INFO - Cleaning up... 11:19:06 INFO - Return code: 0 11:19:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:06 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 0x185c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:06 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 11:19:06 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 11:19:06 INFO - Using env: {'DISPLAY': ':0', 11:19:06 INFO - 'HOME': '/home/cltbld', 11:19:06 INFO - 'LANG': 'en_US.UTF-8', 11:19:06 INFO - 'LANGUAGE': 'en_US:en', 11:19:06 INFO - 'LOGNAME': 'cltbld', 11:19:06 INFO - 'MAIL': '/var/mail/cltbld', 11:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:06 INFO - 'MOZ_NO_REMOTE': '1', 11:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:06 INFO - 'NO_EM_RESTART': '1', 11:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:06 INFO - 'PWD': '/builds/slave/test', 11:19:06 INFO - 'SHELL': '/bin/bash', 11:19:06 INFO - 'SHLVL': '1', 11:19:06 INFO - 'TERM': 'linux', 11:19:06 INFO - 'TMOUT': '86400', 11:19:06 INFO - 'USER': 'cltbld', 11:19:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:06 INFO - '_': '/tools/buildbot/bin/python'} 11:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:19:06 INFO - Cleaning up... 11:19:06 INFO - Return code: 0 11:19:06 INFO - Running post-action listener: _resource_record_post_action 11:19:06 INFO - Running post-action listener: _start_resource_monitoring 11:19:06 INFO - Starting resource monitoring. 11:19:06 INFO - ##### 11:19:06 INFO - ##### Finished create-virtualenv step (success) 11:19:06 INFO - ##### 11:19:06 INFO - ##### 11:19:06 INFO - ##### Running install step. 11:19:06 INFO - ##### 11:19:06 INFO - Running pre-action listener: _resource_record_pre_action 11:19:06 INFO - Running main action method: install 11:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:06 INFO - Reading from file tmpfile_stdout 11:19:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:07 INFO - Reading from file tmpfile_stdout 11:19:07 INFO - Output received: 11:19:07 INFO - Usage: mozinstall [options] installer 11:19:07 INFO - Options: 11:19:07 INFO - -h, --help show this help message and exit 11:19:07 INFO - -d DEST, --destination=DEST 11:19:07 INFO - Directory to install application into. [default: 11:19:07 INFO - "/builds/slave/test"] 11:19:07 INFO - --app=APP Application being installed. [default: firefox] 11:19:07 INFO - mkdir: /builds/slave/test/build/application 11:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:19:24 INFO - Reading from file tmpfile_stdout 11:19:24 INFO - Output received: 11:19:24 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:24 INFO - Running post-action listener: _resource_record_post_action 11:19:24 INFO - ##### 11:19:24 INFO - ##### Finished install step (success) 11:19:24 INFO - ##### 11:19:24 INFO - ##### 11:19:24 INFO - ##### Running run-tests step. 11:19:24 INFO - ##### 11:19:24 INFO - Running pre-action listener: _resource_record_pre_action 11:19:24 INFO - Running main action method: run_tests 11:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:24 INFO - Python 2.7.3 11:19:24 INFO - Return code: 0 11:19:24 INFO - grabbing minidump binary from tooltool 11:19:24 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')]} 11:19:24 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/linux64/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 0x1b1b3b0>, '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 0x1b1c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:24 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:19:24 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/linux64/releng.manifest -o -c /builds/tooltool_cache 11:19:24 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:19:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:24 INFO - Return code: 0 11:19:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:24 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:19:24 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:19:24 INFO - Using env: {'DISPLAY': ':0', 11:19:24 INFO - 'HOME': '/home/cltbld', 11:19:24 INFO - 'LANG': 'en_US.UTF-8', 11:19:24 INFO - 'LANGUAGE': 'en_US:en', 11:19:24 INFO - 'LOGNAME': 'cltbld', 11:19:24 INFO - 'MAIL': '/var/mail/cltbld', 11:19:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:24 INFO - 'MOZ_NO_REMOTE': '1', 11:19:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:24 INFO - 'NO_EM_RESTART': '1', 11:19:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:24 INFO - 'PWD': '/builds/slave/test', 11:19:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:24 INFO - 'SHELL': '/bin/bash', 11:19:24 INFO - 'SHLVL': '1', 11:19:24 INFO - 'TERM': 'linux', 11:19:24 INFO - 'TMOUT': '86400', 11:19:24 INFO - 'USER': 'cltbld', 11:19:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467828731.204701-737714826', 11:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:24 INFO - '_': '/tools/buildbot/bin/python'} 11:19:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:19:24 INFO - mozversion application_buildid: 20160706083048 11:19:24 INFO - mozversion application_changeset: 3705eb1dc2cce4582cc3f95af52aeec700801fae 11:19:24 INFO - mozversion application_display_name: Nightly 11:19:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:24 INFO - mozversion application_name: Firefox 11:19:24 INFO - mozversion application_remotingname: firefox 11:19:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:24 INFO - mozversion application_vendor: Mozilla 11:19:24 INFO - mozversion application_version: 50.0a1 11:19:24 INFO - mozversion platform_buildid: 20160706083048 11:19:24 INFO - mozversion platform_changeset: 3705eb1dc2cce4582cc3f95af52aeec700801fae 11:19:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:24 INFO - mozversion platform_version: 50.0a1 11:19:24 INFO - using testdate: 1467829164 11:19:24 INFO - actual date: 1467829164 11:19:24 INFO - starting webserver on 'localhost:52974' 11:19:24 INFO - SUITE-START | Running 2 tests 11:19:24 INFO - TEST-START | dromaeo_css 11:19:24 INFO - operating with platform_type : linux_ 11:19:24 INFO - Initialising browser for dromaeo_css test... 11:19:24 INFO - TEST-INFO | started process 31977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDMZ18w/profile http://localhost:52974/getInfo.html) 11:19:29 INFO - PROCESS | 31977 | __metrics Screen width/height:1600/1200 11:19:29 INFO - PROCESS | 31977 | colorDepth:24 11:19:29 INFO - PROCESS | 31977 | Browser inner width/height: 1024/697 11:19:29 INFO - PROCESS | 31977 | __metrics 11:19:30 ERROR - PROCESS | 31977 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 11:19:31 INFO - TEST-INFO | 31977: exit 0 11:19:31 INFO - Browser initialized. 11:19:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:31 INFO - TEST-INFO | started process 32097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDMZ18w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:43 INFO - PROCESS | 32097 | RSS: Main: 168652800 11:19:43 INFO - PROCESS | 32097 | 11:20:32 INFO - PROCESS | 32097 | 1467829232739 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] 11:22:40 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:52974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52974/tests/dromaeo/cssquery-ext.html) 11:22:42 INFO - PROCESS | 32097 | RSS: Main: 172449792 11:22:42 INFO - PROCESS | 32097 | 11:25:44 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:52974/tests/dromaeo/cssquery-ext.html (next: http://localhost:52974/tests/dromaeo/cssquery-jquery.html) 11:25:44 INFO - PROCESS | 32097 | RSS: Main: 168841216 11:25:44 INFO - PROCESS | 32097 | 11:28:46 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:52974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52974/tests/dromaeo/cssquery-mootools.html) 11:28:47 INFO - PROCESS | 32097 | RSS: Main: 172011520 11:28:47 INFO - PROCESS | 32097 | 11:31:49 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:52974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52974/tests/dromaeo/cssquery-prototype.html) 11:31:49 INFO - PROCESS | 32097 | RSS: Main: 168239104 11:31:49 INFO - PROCESS | 32097 | 11:34:52 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:52974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52974/tests/dromaeo/cssquery-yui.html) 11:34:52 INFO - PROCESS | 32097 | RSS: Main: 169938944 11:34:52 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | Cycle 1(1): loaded http://localhost:52974/tests/dromaeo/cssquery-yui.html (next: http://localhost:52974/tests/dromaeo/cssquery-dojo.html) 11:37:55 INFO - PROCESS | 32097 | RSS: Main: 170741760 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | __start_tp_report 11:37:55 INFO - PROCESS | 32097 | _x_x_mozilla_page_load 11:37:55 INFO - PROCESS | 32097 | _x_x_mozilla_page_load_details 11:37:55 INFO - PROCESS | 32097 | |i|pagename|runs| 11:37:55 INFO - PROCESS | 32097 | |0;dojo.html;3116.937661246775;3164.5886034815485;3184.1402821238257;3208.967910320896;3217.8551965161564;5381.327334083239;5451.400345961946;5467.863303417412;5504.504594586487;5515.062439385304;5365.54392876605;5452.4274951130155;5543.251661025771;5564.304461942257;5631.7184140793;4971.925421118695;4987.625928055392;5019.096562618727;5090.083784918713;5124.461931497195;5007.774650140753;5158.458361872005;5200.817971371002;5209.895802083956;5225.503577160163;4835.347228124193;4953.257011448276;4985.626078044161;5025.673331233458;5059.468755780626;4998.175301075318;5013.147764879943;5013.974930125362;5018.698878067327;5043.596512279046;4985.903101317705;4989.65072444929;4997.725125118117;5010.448850626428;5050.520200580976;5419.756110974976;5454.781808727646;5470.972645136749;5498.615096943216;5546.805861794818;5911.674857882815;5919.467247947706;5920.141579470996;5922.58541902067;5931.317898441691;5717.799877004327;5953.315368732608;5972.940270597282;5973.402659734035;5974.880502389971;5444.836654900319;5471.042567550663;5478.616496845222;5483.8080667176855;5492.505674489235;5999.400059994053;6004.159417681528;6004.699765011819;6006.069059295729;6007.729652165663;5598.748056337475;5695.946249943774;5700.714964251771;5754.309482862083;5757.91363129545;5899.587028908021;5945.078512830518;5954.583179177503;5964.7315870785915;5971.552133589998;5697.316322041299;5783.219265399117;5794.5364370851075;5888.057910734262;5896.793612223637;5779.104238842986;5856.209411729447;5914.497267732205;5921.289445266596;5953.791617293374;4435.489918659331;4446.577575130357;4476.865694029184;4492.101579684011;4492.528284530143;3999;4009.1580768038457;4020.6582440492884;4022.597740225954;4037.4347591337237;5484.122540393598;5582.134769110794;5660.85847853807;5662.37713851476;5670.5180059695385;5919.230500035054;5958.910616340759;5989.9101513477335;5997.640141591519;6049.516038716892;5667.716614169275;5673.347565030074;5674.205611214434;5676.375598684142;5697.059985102412;4915.459299477055;4938.827141050046;4978.800847966113;5113.488651134857;5144.819931302462;5973.820785376446;6076.179715738407;6111.3287157086725;6123.663198524124;6125.203723515914;5875.3243377012195;5885.55858310637;5892.204552385545;5903.26209223847;5961.642301461926;5941.554383421174;5981.730822112929;6050.30421501533;6084.6349219047;6124.326324104434;5696.629719068247;5735.8852822944145;5774.855628609318;5788.942110579009;5825.70871456434;5811.331696854916;5893.057110862242;5900.291964964232;5916.437938395846;5934.9613817580885;5575.693336866511;5746.885062298647;5750.482456578928;5754.338251101177;5778.653280803165;5740.90922724681;5768.134779783066;5773.16289138081;5776.797812076557;5806.129080637938;5663.292088488939;5684.63049901755;5706.372299047184;5718.51392631631;5721.828345149652;5572.888542229051;5697.8860422790485;5796.739146738322;5806.361300256884;5829.183914251923;5642.830715078554;5647.7176141193595;5649.2373529574625;5696.088625819849;5706.828795136153 11:37:55 INFO - PROCESS | 32097 | |1;ext.html;570.2273419516555;588.9646621202727;622.7477871462058;643.0643413832873;688.5317983771033;38727.22545549087;42287.365689514605;42629.360559591594;42640.573594264046;42719;42748.358774618406;42752.07615657295;43143.35284970728;43197.56802431975;43488.56511434885;8668.52323122228;8811.251043661296;8845.071267516914;8882.86675699865;8885.2447541959;8659.783505412384;8728.083551227124;8735.825283494327;8744.562771861381;8745.556983097782;8683.826323473526;8709.25971292441;8750.256228220609;8767.649294028231;8829.646814127427;8683.34874884383;8717;8734.650613975433;8737.563121843914;8741.606627701769;8710.608022638997;8802;8813.07462716412;8814.382993190478;8825.382223244376;40274.194516109514;40415.797921010504;40484.59515404838;40623.59376406228;40630.79684601558;3481.216726236602;3630.5280313559333;3639.1993761372455;3653.1049892776173;4053.9594604053877;31478.527822082688;31932;32197.839010804797;32209.1947701307;32210.83894580512;4280.59334363235;4357.4988876279;4364.432623758891;4443.955560444387;4519.073589914093;327635;328696;329324;329565;330225;55445.72277138669;55623.443765561824;55677.72161139168;56025.43974560202;56072;35492.645073548934;36456.63543364585;36473.817630911675;38271.42592861054;59811;16919.40782072646;16952.915235423745;17076.316947322215;17144.142792860555;17171.227294771765;12215.816762748565;12251;12322.876771232352;12390.62828115158;12443.502259909683;19368.225270989285;19488.8051119487;19495.512612184524;19522.511937201685;19563;7289.671964761598;7391.556506609621;7425.9574277034335;7487.5507469552;7583.810404739816;939.2673714502699;1065.0201814330835;1079.2768844873797;1108.8203879877726;1182.822576613515;32882.67117328796;32963.66540227581;33169.50245746316;33273;33676.66323336784;1070.539667942792;1087.2932593814085;1129.5877004893155;1144.5650652752067;1148.2364227788428;16874.74687879683;17212.655746884993;17235.482935511955;17272.22274997628;17326.826731732523;591273;627564;635497;641182;643444;57637;58192;58529;63634;63679.68160159169;1364.740699267136;1377.3319939829375;1385.8752712255744;1389.9930500347434;1396.1762560089596;31490;34369.62943406425;34558;34806.65193348034;35113.297734045686;53707;53918.73040634772;53945.19082213849;54097.72951135219;54131.45868541264;559195;563180;564299;564319;564627;43304;44694;44707;44839.775801120784;47434.52565474301;47260.527394725614;47881.52118478771;48437.5156248433;48530.5146948526;48914.266286005026;40561.18877622372;40907.59092409038;42179.57820421879;42392.1521569573;43377.3493397593;41533.37699934443;41849.79075104605;41852;42322.36516452194;42546;41158.38262426006;41423.1715365697;42318.36522452104;42326.36510452407;44746.77626611976;41352.37971430491;43939.78030109829;44400.333994990746;48487;48503.75748121237;32129.35741285208;33302.333953321286;35530.46704299489;35895.461568075974;35927.64072359243 11:37:55 INFO - PROCESS | 32097 | |2;jquery.html;388.8930544100373;390.6620773031329;391.1180288449546;398.998005009975;416.77285879195836;13829.446822127104;18427.262909483623;19345.61308773824;19824.60350792985;19982.20071197154;19035.428937131874;19090.140943657534;19299.421017369466;20196.899015504903;20261.290854820083;5682.829515114553;5799.681017544033;5800.535957123441;5845;5889.8822023559505;5537.750801213935;5795.594308398414;5816.156657284691;5827.184194212814;5860.560457965648;5783.942160578404;5808.651480911138;5827.592068555182;5870.236869206997;5925.970370148165;5915.378885217055;5948.524118070565;6061.727222275008;6165.106059621375;6187.907181392283;4985.5513003829465;5267.28891599633;5318;6013.308469525973;6059.545534084918;14161.504347347793;14206.289685515787;14298;21155.47111322214;22031.228906988337;2345.8006069484113;2396.341006223285;2478.8388754730886;2788.3168623687325;2864;10163.288569800043;10206.336588121823;10517.263791534595;10566.260361774679;10745;1979.2775636892432;1995.9201631934704;2005.177877070394;2042.5710600773855;2092.686097085434;79998.20001800024;80859.5957020211;81399.59300203461;81711.9999999994;82632.17367826364;11016.669499915015;11054.447277636085;11448.828267575993;11555.88444115565;11677.708057298636;15390;15423;15463.226838658022;15524.456644017406;15547.922260388626;7914.960425197953;7965.402594805413;8015.47899386538;8042.638081286239;8263.380246481538;7439.218882017419;7449.925500744923;7528.887066694004;7636.121845987783;7736.988383020455;4333.414988976448;4477.238869392211;4694.671373003857;4862.124817532807;4924.064427758714;1984.28565716342;2024.6962955556785;2029.8173164415273;2051.4050925231813;2052.271443637517;931.8136372725482;937.3953799799092;977.1645243317004;979.1872745621117;1059.3590877519143;19582.412527624194;19882.50293742639;19955.401337959884;19956;20124.798752012586;991.5637119667323;999.7250756042001;1009.9899001010043;1033.715728174743;1047.8009178256107;10553.366797991992;11053.889461105286;11064.28082174672;11097.38964356952;11183.384913829817;351052;457332;463530;492550;494523;64925.67537162379;102461;102643;103758.48120759348;104160;994.8457989011715;997.4214955325893;1052.3948729480733;1066.7973085113804;1067.1196263082988;14914.701705966037;17080.23138958775;17143.571410714332;17609.20758565842;18826;44934.55065449434;45479.772601136785;45561.31658025199;46076.7696161517;46205.37946205353;59328.40671593229;60477.39522604718;60581.39418605757;62563.68718156562;62819.37180628135;7052.400545953446;7438.033055702724;8781.385303028983;9016.639334426813;9104.590293436679;12444.626661200178;12870.16343937641;12903;13141.737165256833;13234.205947643171;5692.971535142297;9750.561224744763;10172.84740728875;10979.890201098206;11187.160962927976;11060.446977651247;11106.833397498882;11181.273217240854;11220.495077721685;11601.477933492844;11249.381284029458;11262.662120136409;11271.661850144508;11458.656240312805;11524;7394.926050739639;7509.6245187739305;7653.081630204411;7660.119086305146;7674.8081297968;11081.667549973514;11242.269252498561;11403.091557669639;11496.655100347003;11499 11:37:55 INFO - PROCESS | 32097 | |3;mootools.html;1477.8226612806466;1490.6198919275582;1653.5618061213781;1814.3921786201622;1816.0102744004507;7991.9600401997905;8269.917300827005;8649.524276164808;9298.72103836885;9355.158035776787;8262.256396924291;8511.914880851189;8521.829563408728;8528.616212270446;8613.741587752362;2268.319504148753;2271.4207876991345;2287.63397856343;2294.105298933417;2306.215886598556;2251.966220506694;2283.668868014137;2302.4128847143957;2314.3866875278063;2322.837401381904;2280.1677387753516;2308.861468311898;2310.5378924215142;2312.8612283262974;2325.6744055832114;2265.365697604673;2270.750217476076;2272.3523795718224;2275.920342788003;2293.9770602294016;2221.8222542196586;2241;2245.494763678176;2246.1576908659254;2251;8543.572821358906;8570.74287771368;8592.8711069334;8648.481091134552;8649.740507784776;5384.300040994684;5498.532624726863;5509.779608815643;5524.944750552483;5534.308211473566;3370.713489353408;3460.602030766469;3519.8240087995496;3576.3204991051616;3584.318979393907;1230.655416483386;1239.9442025108892;1252.0984890878644;1266.5820279307807;2163.7728038555883;12624.116311858174;12635.368231588476;12663.240205587603;12700.364981750876;12771.808422873664;4548.317752337176;4557.931631025537;4648.163330600524;4768.213244814636;4779.784909679072;10062.345947513388;10117.595296188218;10129.594816207416;10158.695239142837;10159.288849780445;5447.673139611636;5457.45425457459;5459.617826752089;5464.480874316933;5476;4165.042040330741;4801.327814106028;4865.756712164449;5032.220005899091;5069.264956581275;3882.8835134946;3918.74528155669;3936.7834769087403;3973.324534829086;4005.319095753729;1148.7817314710178;1170.0756402442146;1176.8823117688162;1185.958491452795;1190.9166358355005;977.9780129764413;982.3221976835961;1001.2840818814583;1009.2834087797746;1018.1752780248023;6210.31686514483;6215.906761398583;6265.624062556261;6294.842628934313;6487.837804054936;431.3185167435444;434.42004923426947;434.5979968529098;436.3563743478344;443.96448284137193;4251.511076226212;4319.913601727948;4329.177456283296;4340.435743353344;4348.456442944632;11191.440427978569;11392.487338069806;11575.305481671126;11595.362255075883;11600.6519804406;10576.471176441148;11327.697314808738;11385.658430247106;11461.426928653535;11469.713257168638;8041.6381262843315;8371.832563348698;8445.535495547681;8467.195616416431;8478.406511544134;6152.538559608137;6348.682565871781;6427.646479443675;6482.611043337415;6575.079488871657;10411.531481083219;10535.315204511682;10537.736556586147;10568.788624227625;10585.470726463493;10202.132818710492;10481;10504.369737815756;10528.210384221062;10566.207534434794;7944.801379965547;7977.361811055218;8122.918770812216;8387.07742148351;8721.520316382659;8959.552022398724;9036.05121462237;9103.817923641622;9107.408018478778;9149.86275205859;7825;7943.24539168778;8047.0745864226365;8177.182281771775;8199.180081991753;7765.262300081483;7830.373570114263;7969.760907172794;7971.362291016821;7993.920060799318;7399.149097853816;7449.180590135189;7470.701171953278;7552.811179720551;7584.886226706714;5331.946680533145;5396.406395296436;5417.620766546304;5445.428230035789;5586.190002449704;5561.360443548881;5562.694051827189;5725.141228815711;5765.740541675551;5794.507466865195 11:37:55 INFO - PROCESS | 32097 | |4;prototype.html;326.828415082082;337.5813990651592;338.6004514672686;339.4907638542187;340.3550272234118;5557.110862262039;5619.297587801525;5685.857853553658;5756.712164391779;5800.361960184382;5619.887602247953;5626.915596266049;5693.829185124442;5720.713964301779;5736.397678243787;4394.450693663292;4412.227860124482;4429.6899217054815;4451.243288640939;4460.375547423363;4342.088161486092;4393.860769599242;4398.890027749316;4424.77876106195;4443.866683999469;4306.224879521685;4311.1593239318345;4329.653627709776;4361.9345709814215;4435.246008178601;4336.6530677545725;4376.584224498668;4400.7579583122915;4401.427814384109;4417.31531612599;3780.451834484012;3858.8649397271242;3871.361225397834;3879.3405121129476;3908.9609103908883;5403.406364944848;5443.237946687467;5474.178873169017;5516.834494965157;5581.5813813963705;5018.272350509155;5052.242163675442;5052.898942021176;5065.645404821664;5099.949000509984;5752.539796816286;5907.5864689471755;5943.821685349447;5977.641341519523;6015.54883383748;4277.97861010696;4296.398504209413;4305.526392096866;4310.396544483743;4310.892227694301;6172;6193.628382297076;6237.469815065725;6256.812295631138;6256.937430625681;4017.959820401817;4244.38456423823;4287.914241715148;4299.720518166309;4329.480462344539;4324.654027677778;4351.956480435155;4372.453443319585;4377.6497880170145;4378.211921854033;4984.675996060245;4994.076095922193;5021.422536408287;5036.949630503648;5058.54473097423;5739.655620662774;5764.587676019402;5884.411558844081;5934.703264836741;5974.3726908674835;1483.4288798812536;1503.5414198669512;1514.6516301250554;1515.5983664328962;1523.2688309611449;898.9685361012333;932.8600709893434;950.695777351241;953.2850362228329;957.7940742740344;4950.2079667253065;4990.251462280687;5023.522765337287;5025.623078269071;5135.613384386194;5336.386315573681;5369.5972802040005;5374.811881584125;5393.894251678396;5428.972855135699;4823.710577365369;5024.995000999815;5080.882205914693;5082.796688132507;5084.949030581695;2851.519178314838;2885.697001814779;2888.3789985153294;2891.4361699468823;2901.8537677617646;5381.112116500812;5383.192521121863;5388.865278367994;5475.890482190413;5535.121736696976;5376.946230537645;5787.363390027093;6280.623162610258;6287.339829317947;6299.401556852092;6316.842078948063;6356.904646430307;6403.423691867662;6408.903866442007;6415.615063096229;5984.581079324405;6107.877842443215;6135.53983451234;6163.876722465615;6216.2540495140875;6081.84444955457;6082.817515474543;6109.816705498843;6110.69446527663;6139.465133716571;6081.756729730938;6273.686315684106;6327.90508142369;6339.936600634119;6403.231612206565;4286.142771445661;4297.119090586485;4303.505096913895;4319.33050377192;4347.978225117158;5915.556333275108;5985.940140598538;6122.204113465221;6192.473639740672;6196.721147548281;5913.29040515141;5952;5957.765837810821;5993.160957465871;6051.909221361595;5824.563157763269;5921.2006379138265;5922.89737143308;5936.050231962865;5955.880882382415;5663.292088488939;5824.835032993334;5826.533877289722;5830.9416905832095;5904.675242861512;5961.165436838933;6036.154938308552;6084.904717150778;6115.510759139169;6123.2652081750475;5599.664020158803;5830.912536311874;5836.416358364299;5841.357450680507;5867.946218823548 11:37:55 INFO - PROCESS | 32097 | |5;yui.html;725.9419246460284;780.1379475679374;784.6429874407145;802.0255389701515;871.6252011634998;13156.473741050359;14000.439982400718;14009;14077.296135193224;14192.716145677081;14600;14774.704505909902;14922.477713280037;15566.844331556682;15600.687986240267;814.6944895664126;829.0838623321233;832.7335252719132;833.5082301442147;836.3560058754755;784.8273379856422;800.2077942836609;803.4897839871694;804.3364224514769;806.4677312973439;850.0394554153828;850.6639877248483;852.7484392104313;853.3088198559155;853.8761879527495;837.2548431895588;840.3739214285366;842.9957850210741;843.9789005274856;847.0428415890004;614.7663887722681;615.4276522833762;616.6176970278456;617.5245061302817;621.4158690830604;14513.637159071002;14522.346494407671;14659;14702.338394772261;14708.779368309484;15191.772123418157;15235.771463428058;15235.771463428058;15238.847611523965;15319.693606127816;12500.24998500093;12622.495100195982;12736.095558044046;12757.107002509829;13065.934670326587;3896.902577435558;3907.902302442433;3943.7239393242485;4019.356902895552;4062.9593704063172;77902;78054.60972695157;78292;79907.60046199789;80459.79310310408;11283.210175287815;11353.829692554618;11520.596779112859;11728.88271117295;12015.699607509881;21853.453663658216;21884.562308753735;22025.22911698083;22056.88971555132;22083.889580551993;8704.390692651454;8726.520041397784;8899.644014239359;8962.775930601787;9215.124563166488;4894.290327902434;4897.289892965571;4921.384826896638;4923.630727695438;5059.442215188311;3413.2661477782394;3504.141485336058;3544.078539579728;3550.3076900004253;3561.9643803562153;601.7683191971123;606.6572386601556;613.7606333529927;615.0436071908225;621.869407424446;756.2324240895496;789.5144486141097;790.1229635105029;800.7517669522466;822.2188920525525;10013.799724005625;10259.127974122133;10594.728632563987;10627.628033018962;10835.83746243807;644.9032645103272;720.7837648705367;775.9262870027338;805.1746959366697;808.458332916947;5059.342285502935;5197.558207552324;5246.606504512177;5274.97362513185;5286.920696189561;95771;95935;100056.4997175024;116873;117051;84819;98335.50832245935;99519.50240248753;101023;101153;82027.58986205031;82081;83240.58379708184;84482.15517844865;88107.99999999872;10262.538185781807;10436;10665.200109991627;10747.731306717082;10825.891741082489;48229.75885120552;48810.5118948806;49913;50057.24914126218;50520.24219636635;73976.2602373991;77062.6146869262;77615.61192194003;78247.21752782399;79434.6028269855;12974.740505190031;13126.60620181396;13252.20486770797;13437.731245374842;13909.791353129913;15622;15680;15816.683666326839;16020.519384418487;16106.355745770506;14092.154470731788;14194.787078193629;14238.430462781787;14539.709205816036;15115.31981060833;14247.64380890486;14391.784123238369;14652.487162949246;14677.779833302295;14969.176695281863;14055;14534.345954431865;14665.340059697553;14715.779263311273;14741.778873317124;11105.111680231319;11393.560549684908;11400.657980260274;11959.940200298943;12085.516579336729;11300.43497825089;11583.8262426062;11698.649040528799;12408.107932995103;12754.298513581842 11:37:55 INFO - PROCESS | 32097 | __end_tp_report 11:37:55 INFO - PROCESS | 32097 | __start_cc_report 11:37:55 INFO - PROCESS | 32097 | _x_x_mozilla_cycle_collect,354 11:37:55 INFO - PROCESS | 32097 | __end_cc_report 11:37:55 INFO - PROCESS | 32097 | __startTimestamp1467830275531__endTimestamp 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | ------- Summary: start ------- 11:37:55 INFO - PROCESS | 32097 | Number of tests: 6 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | [#0] dojo.html Cycles:165 Average:5471.18 Median:5695.95 stddev:621.55 (10.9%) stddev-sans-first:595.39 11:37:55 INFO - PROCESS | 32097 | Values: 3116.9 3164.6 3184.1 3209.0 3217.9 5381.3 5451.4 5467.9 5504.5 5515.1 5365.5 5452.4 5543.3 5564.3 5631.7 4971.9 4987.6 5019.1 5090.1 5124.5 5007.8 5158.5 5200.8 5209.9 5225.5 4835.3 4953.3 4985.6 5025.7 5059.5 4998.2 5013.1 5014.0 5018.7 5043.6 4985.9 4989.7 4997.7 5010.4 5050.5 5419.8 5454.8 5471.0 5498.6 5546.8 5911.7 5919.5 5920.1 5922.6 5931.3 5717.8 5953.3 5972.9 5973.4 5974.9 5444.8 5471.0 5478.6 5483.8 5492.5 5999.4 6004.2 6004.7 6006.1 6007.7 5598.7 5695.9 5700.7 5754.3 5757.9 5899.6 5945.1 5954.6 5964.7 5971.6 5697.3 5783.2 5794.5 5888.1 5896.8 5779.1 5856.2 5914.5 5921.3 5953.8 4435.5 4446.6 4476.9 4492.1 4492.5 3999.0 4009.2 4020.7 4022.6 4037.4 5484.1 5582.1 5660.9 5662.4 5670.5 5919.2 5958.9 5989.9 5997.6 6049.5 5667.7 5673.3 5674.2 5676.4 5697.1 4915.5 4938.8 4978.8 5113.5 5144.8 5973.8 6076.2 6111.3 6123.7 6125.2 5875.3 5885.6 5892.2 5903.3 5961.6 5941.6 5981.7 6050.3 6084.6 6124.3 5696.6 5735.9 5774.9 5788.9 5825.7 5811.3 5893.1 5900.3 5916.4 5935.0 5575.7 5746.9 5750.5 5754.3 5778.7 5740.9 5768.1 5773.2 5776.8 5806.1 5663.3 5684.6 5706.4 5718.5 5721.8 5572.9 5697.9 5796.7 5806.4 5829.2 5642.8 5647.7 5649.2 5696.1 5706.8 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | [#1] ext.html Cycles:180 Average:66248.71 Median:42679.79 stddev:139474.09 (326.8%) stddev-sans-first:139778.18 11:37:55 INFO - PROCESS | 32097 | Values: 570.2 589.0 622.7 643.1 688.5 38727.2 42287.4 42629.4 42640.6 42719.0 42748.4 42752.1 43143.4 43197.6 43488.6 8668.5 8811.3 8845.1 8882.9 8885.2 8659.8 8728.1 8735.8 8744.6 8745.6 8683.8 8709.3 8750.3 8767.6 8829.6 8683.3 8717.0 8734.7 8737.6 8741.6 8710.6 8802.0 8813.1 8814.4 8825.4 40274.2 40415.8 40484.6 40623.6 40630.8 3481.2 3630.5 3639.2 3653.1 4054.0 31478.5 31932.0 32197.8 32209.2 32210.8 4280.6 4357.5 4364.4 4444.0 4519.1 327635.0 328696.0 329324.0 329565.0 330225.0 55445.7 55623.4 55677.7 56025.4 56072.0 35492.6 36456.6 36473.8 38271.4 59811.0 16919.4 16952.9 17076.3 17144.1 17171.2 12215.8 12251.0 12322.9 12390.6 12443.5 19368.2 19488.8 19495.5 19522.5 19563.0 7289.7 7391.6 7426.0 7487.6 7583.8 939.3 1065.0 1079.3 1108.8 1182.8 32882.7 32963.7 33169.5 33273.0 33676.7 1070.5 1087.3 1129.6 1144.6 1148.2 16874.7 17212.7 17235.5 17272.2 17326.8 591273.0 627564.0 635497.0 641182.0 643444.0 57637.0 58192.0 58529.0 63634.0 63679.7 1364.7 1377.3 1385.9 1390.0 1396.2 31490.0 34369.6 34558.0 34806.7 35113.3 53707.0 53918.7 53945.2 54097.7 54131.5 559195.0 563180.0 564299.0 564319.0 564627.0 43304.0 44694.0 44707.0 44839.8 47434.5 47260.5 47881.5 48437.5 48530.5 48914.3 40561.2 40907.6 42179.6 42392.2 43377.3 41533.4 41849.8 41852.0 42322.4 42546.0 41158.4 41423.2 42318.4 42326.4 44746.8 41352.4 43939.8 44400.3 48487.0 48503.8 32129.4 33302.3 35530.5 35895.5 35927.6 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | [#2] jquery.html Cycles:180 Average:27982.79 Median:2437.59 stddev:75473.85 (3096.2%) stddev-sans-first:75657.14 11:37:55 INFO - PROCESS | 32097 | Values: 388.9 390.7 391.1 399.0 416.8 13829.4 18427.3 19345.6 19824.6 19982.2 19035.4 19090.1 19299.4 20196.9 20261.3 5682.8 5799.7 5800.5 5845.0 5889.9 5537.8 5795.6 5816.2 5827.2 5860.6 5783.9 5808.7 5827.6 5870.2 5926.0 5915.4 5948.5 6061.7 6165.1 6187.9 4985.6 5267.3 5318.0 6013.3 6059.5 14161.5 14206.3 14298.0 21155.5 22031.2 2345.8 2396.3 2478.8 2788.3 2864.0 10163.3 10206.3 10517.3 10566.3 10745.0 1979.3 1995.9 2005.2 2042.6 2092.7 79998.2 80859.6 81399.6 81712.0 82632.2 11016.7 11054.4 11448.8 11555.9 11677.7 15390.0 15423.0 15463.2 15524.5 15547.9 7915.0 7965.4 8015.5 8042.6 8263.4 7439.2 7449.9 7528.9 7636.1 7737.0 4333.4 4477.2 4694.7 4862.1 4924.1 1984.3 2024.7 2029.8 2051.4 2052.3 931.8 937.4 977.2 979.2 1059.4 19582.4 19882.5 19955.4 19956.0 20124.8 991.6 999.7 1010.0 1033.7 1047.8 10553.4 11053.9 11064.3 11097.4 11183.4 351052.0 457332.0 463530.0 492550.0 494523.0 64925.7 102461.0 102643.0 103758.5 104160.0 994.8 997.4 1052.4 1066.8 1067.1 14914.7 17080.2 17143.6 17609.2 18826.0 44934.6 45479.8 45561.3 46076.8 46205.4 59328.4 60477.4 60581.4 62563.7 62819.4 7052.4 7438.0 8781.4 9016.6 9104.6 12444.6 12870.2 12903.0 13141.7 13234.2 5693.0 9750.6 10172.8 10979.9 11187.2 11060.4 11106.8 11181.3 11220.5 11601.5 11249.4 11262.7 11271.7 11458.7 11524.0 7394.9 7509.6 7653.1 7660.1 7674.8 11081.7 11242.3 11403.1 11496.7 11499.0 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | [#3] mootools.html Cycles:180 Average:5957.53 Median:4344.45 stddev:3411.39 (78.5%) stddev-sans-first:3404.34 11:37:55 INFO - PROCESS | 32097 | Values: 1477.8 1490.6 1653.6 1814.4 1816.0 7992.0 8269.9 8649.5 9298.7 9355.2 8262.3 8511.9 8521.8 8528.6 8613.7 2268.3 2271.4 2287.6 2294.1 2306.2 2252.0 2283.7 2302.4 2314.4 2322.8 2280.2 2308.9 2310.5 2312.9 2325.7 2265.4 2270.8 2272.4 2275.9 2294.0 2221.8 2241.0 2245.5 2246.2 2251.0 8543.6 8570.7 8592.9 8648.5 8649.7 5384.3 5498.5 5509.8 5524.9 5534.3 3370.7 3460.6 3519.8 3576.3 3584.3 1230.7 1239.9 1252.1 1266.6 2163.8 12624.1 12635.4 12663.2 12700.4 12771.8 4548.3 4557.9 4648.2 4768.2 4779.8 10062.3 10117.6 10129.6 10158.7 10159.3 5447.7 5457.5 5459.6 5464.5 5476.0 4165.0 4801.3 4865.8 5032.2 5069.3 3882.9 3918.7 3936.8 3973.3 4005.3 1148.8 1170.1 1176.9 1186.0 1190.9 978.0 982.3 1001.3 1009.3 1018.2 6210.3 6215.9 6265.6 6294.8 6487.8 431.3 434.4 434.6 436.4 444.0 4251.5 4319.9 4329.2 4340.4 4348.5 11191.4 11392.5 11575.3 11595.4 11600.7 10576.5 11327.7 11385.7 11461.4 11469.7 8041.6 8371.8 8445.5 8467.2 8478.4 6152.5 6348.7 6427.6 6482.6 6575.1 10411.5 10535.3 10537.7 10568.8 10585.5 10202.1 10481.0 10504.4 10528.2 10566.2 7944.8 7977.4 8122.9 8387.1 8721.5 8959.6 9036.1 9103.8 9107.4 9149.9 7825.0 7943.2 8047.1 8177.2 8199.2 7765.3 7830.4 7969.8 7971.4 7993.9 7399.1 7449.2 7470.7 7552.8 7584.9 5331.9 5396.4 5417.6 5445.4 5586.2 5561.4 5562.7 5725.1 5765.7 5794.5 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | [#4] prototype.html Cycles:180 Average:4906.15 Median:5458.71 stddev:1462.84 (26.8%) stddev-sans-first:1425.99 11:37:55 INFO - PROCESS | 32097 | Values: 326.8 337.6 338.6 339.5 340.4 5557.1 5619.3 5685.9 5756.7 5800.4 5619.9 5626.9 5693.8 5720.7 5736.4 4394.5 4412.2 4429.7 4451.2 4460.4 4342.1 4393.9 4398.9 4424.8 4443.9 4306.2 4311.2 4329.7 4361.9 4435.2 4336.7 4376.6 4400.8 4401.4 4417.3 3780.5 3858.9 3871.4 3879.3 3909.0 5403.4 5443.2 5474.2 5516.8 5581.6 5018.3 5052.2 5052.9 5065.6 5099.9 5752.5 5907.6 5943.8 5977.6 6015.5 4278.0 4296.4 4305.5 4310.4 4310.9 6172.0 6193.6 6237.5 6256.8 6256.9 4018.0 4244.4 4287.9 4299.7 4329.5 4324.7 4352.0 4372.5 4377.6 4378.2 4984.7 4994.1 5021.4 5036.9 5058.5 5739.7 5764.6 5884.4 5934.7 5974.4 1483.4 1503.5 1514.7 1515.6 1523.3 899.0 932.9 950.7 953.3 957.8 4950.2 4990.3 5023.5 5025.6 5135.6 5336.4 5369.6 5374.8 5393.9 5429.0 4823.7 5025.0 5080.9 5082.8 5084.9 2851.5 2885.7 2888.4 2891.4 2901.9 5381.1 5383.2 5388.9 5475.9 5535.1 5376.9 5787.4 6280.6 6287.3 6299.4 6316.8 6356.9 6403.4 6408.9 6415.6 5984.6 6107.9 6135.5 6163.9 6216.3 6081.8 6082.8 6109.8 6110.7 6139.5 6081.8 6273.7 6327.9 6339.9 6403.2 4286.1 4297.1 4303.5 4319.3 4348.0 5915.6 5985.9 6122.2 6192.5 6196.7 5913.3 5952.0 5957.8 5993.2 6051.9 5824.6 5921.2 5922.9 5936.1 5955.9 5663.3 5824.8 5826.5 5830.9 5904.7 5961.2 6036.2 6084.9 6115.5 6123.3 5599.7 5830.9 5836.4 5841.4 5867.9 11:37:55 INFO - PROCESS | 32097 | 11:37:55 INFO - PROCESS | 32097 | [#5] yui.html Cycles:180 Average:20769.60 Median:3902.40 stddev:29019.23 (743.6%) stddev-sans-first:29061.61 11:37:55 INFO - PROCESS | 32097 | Values: 725.9 780.1 784.6 802.0 871.6 13156.5 14000.4 14009.0 14077.3 14192.7 14600.0 14774.7 14922.5 15566.8 15600.7 814.7 829.1 832.7 833.5 836.4 784.8 800.2 803.5 804.3 806.5 850.0 850.7 852.7 853.3 853.9 837.3 840.4 843.0 844.0 847.0 614.8 615.4 616.6 617.5 621.4 14513.6 14522.3 14659.0 14702.3 14708.8 15191.8 15235.8 15235.8 15238.8 15319.7 12500.2 12622.5 12736.1 12757.1 13065.9 3896.9 3907.9 3943.7 4019.4 4063.0 77902.0 78054.6 78292.0 79907.6 80459.8 11283.2 11353.8 11520.6 11728.9 12015.7 21853.5 21884.6 22025.2 22056.9 22083.9 8704.4 8726.5 8899.6 8962.8 9215.1 4894.3 4897.3 4921.4 4923.6 5059.4 3413.3 3504.1 3544.1 3550.3 3562.0 601.8 606.7 613.8 615.0 621.9 756.2 789.5 790.1 800.8 822.2 10013.8 10259.1 10594.7 10627.6 10835.8 644.9 720.8 775.9 805.2 808.5 5059.3 5197.6 5246.6 5275.0 5286.9 95771.0 95935.0 100056.5 116873.0 117051.0 84819.0 98335.5 99519.5 101023.0 101153.0 82027.6 82081.0 83240.6 84482.2 88108.0 10262.5 10436.0 10665.2 10747.7 10825.9 48229.8 48810.5 49913.0 50057.2 50520.2 73976.3 77062.6 77615.6 78247.2 79434.6 12974.7 13126.6 13252.2 13437.7 13909.8 15622.0 15680.0 15816.7 16020.5 16106.4 14092.2 14194.8 14238.4 14539.7 15115.3 14247.6 14391.8 14652.5 14677.8 14969.2 14055.0 14534.3 14665.3 14715.8 14741.8 11105.1 11393.6 11400.7 11959.9 12085.5 11300.4 11583.8 11698.6 12408.1 12754.3 11:37:55 INFO - PROCESS | 32097 | -------- Summary: end -------- 11:37:55 INFO - PROCESS | 32097 | 11:37:56 INFO - TEST-INFO | 32097: exit 0 11:37:56 INFO - TEST-OK | dromaeo_css | took 1111753ms 11:37:56 INFO - TEST-START | kraken 11:37:56 INFO - operating with platform_type : linux_ 11:37:56 INFO - Initialising browser for kraken test... 11:37:56 INFO - TEST-INFO | started process 32343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpph1Pts/profile http://localhost:52974/getInfo.html) 11:38:00 INFO - PROCESS | 32343 | __metrics Screen width/height:1600/1200 11:38:00 INFO - PROCESS | 32343 | colorDepth:24 11:38:00 INFO - PROCESS | 32343 | Browser inner width/height: 1024/697 11:38:00 INFO - PROCESS | 32343 | __metrics 11:38:01 ERROR - PROCESS | 32343 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 11:38:02 INFO - TEST-INFO | 32343: exit 0 11:38:02 INFO - Browser initialized. 11:38:02 INFO - Running cycle 1/1 for kraken test... 11:38:02 INFO - TEST-INFO | started process 32464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpph1Pts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:14 INFO - PROCESS | 32464 | RSS: Main: 168693760 11:38:14 INFO - PROCESS | 32464 | 11:38:16 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52974/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:17 INFO - PROCESS | 32464 | RSS: Main: 174444544 11:38:17 INFO - PROCESS | 32464 | 11:38:20 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52974/tests/kraken/driver.html?testName=audio-dft) 11:38:21 INFO - PROCESS | 32464 | RSS: Main: 173379584 11:38:21 INFO - PROCESS | 32464 | 11:38:23 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52974/tests/kraken/driver.html?testName=audio-fft) 11:38:24 INFO - PROCESS | 32464 | RSS: Main: 168214528 11:38:24 INFO - PROCESS | 32464 | 11:38:26 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52974/tests/kraken/driver.html?testName=audio-oscillator) 11:38:27 INFO - PROCESS | 32464 | RSS: Main: 169467904 11:38:27 INFO - PROCESS | 32464 | 11:38:29 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:30 INFO - PROCESS | 32464 | RSS: Main: 169885696 11:38:30 INFO - PROCESS | 32464 | 11:38:33 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52974/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:33 INFO - PROCESS | 32464 | RSS: Main: 170270720 11:38:33 INFO - PROCESS | 32464 | 11:38:37 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52974/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:38 INFO - PROCESS | 32464 | RSS: Main: 167567360 11:38:38 INFO - PROCESS | 32464 | 11:38:40 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52974/tests/kraken/driver.html?testName=json-parse-financial) 11:38:41 INFO - PROCESS | 32464 | RSS: Main: 169144320 11:38:41 INFO - PROCESS | 32464 | 11:38:43 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:43 INFO - PROCESS | 32464 | RSS: Main: 169762816 11:38:43 INFO - PROCESS | 32464 | 11:38:45 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:46 INFO - PROCESS | 32464 | RSS: Main: 170078208 11:38:46 INFO - PROCESS | 32464 | 11:38:48 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:48 INFO - PROCESS | 32464 | RSS: Main: 170209280 11:38:48 INFO - PROCESS | 32464 | 11:38:51 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:52 INFO - PROCESS | 32464 | RSS: Main: 170442752 11:38:52 INFO - PROCESS | 32464 | 11:38:54 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:55 INFO - PROCESS | 32464 | RSS: Main: 170360832 11:38:55 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | Cycle 1(1): loaded http://localhost:52974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52974/tests/kraken/driver.html?testName=ai-astar) 11:38:57 INFO - PROCESS | 32464 | RSS: Main: 170557440 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | __start_tp_report 11:38:57 INFO - PROCESS | 32464 | _x_x_mozilla_page_load 11:38:57 INFO - PROCESS | 32464 | _x_x_mozilla_page_load_details 11:38:57 INFO - PROCESS | 32464 | |i|pagename|runs| 11:38:57 INFO - PROCESS | 32464 | |0;ai-astar;102;112;105;115;113;113;117;112;115;112 11:38:57 INFO - PROCESS | 32464 | |1;audio-beat-detection;152;121;147;170;120;145;151;124;186;124 11:38:57 INFO - PROCESS | 32464 | |2;audio-dft;164;164;166;164;165;166;172;164;164;164 11:38:57 INFO - PROCESS | 32464 | |3;audio-fft;87;75;76;146;77;76;75;75;176;76 11:38:57 INFO - PROCESS | 32464 | |4;audio-oscillator;85;85;142;86;85;87;143;87;86;153 11:38:57 INFO - PROCESS | 32464 | |5;imaging-gaussian-blur;117;118;118;118;118;117;119;117;118;118 11:38:57 INFO - PROCESS | 32464 | |6;imaging-darkroom;147;149;148;149;147;148;148;148;148;149 11:38:57 INFO - PROCESS | 32464 | |7;imaging-desaturate;97;96;96;96;96;97;96;96;96;96 11:38:57 INFO - PROCESS | 32464 | |8;json-parse-financial;55;56;55;62;54;56;57;55;56;56 11:38:57 INFO - PROCESS | 32464 | |9;json-stringify-tinderbox;61;63;61;62;63;62;62;63;63;62 11:38:57 INFO - PROCESS | 32464 | |10;stanford-crypto-aes;75;79;75;83;76;75;75;76;81;82 11:38:57 INFO - PROCESS | 32464 | |11;stanford-crypto-ccm;127;122;119;120;127;132;121;122;206;136 11:38:57 INFO - PROCESS | 32464 | |12;stanford-crypto-pbkdf2;161;158;159;160;158;159;162;160;157;160 11:38:57 INFO - PROCESS | 32464 | |13;stanford-crypto-sha256-iterative;65;66;65;63;66;64;67;67;63;62 11:38:57 INFO - PROCESS | 32464 | __end_tp_report 11:38:57 INFO - PROCESS | 32464 | __start_cc_report 11:38:57 INFO - PROCESS | 32464 | _x_x_mozilla_cycle_collect,926 11:38:57 INFO - PROCESS | 32464 | __end_cc_report 11:38:57 INFO - PROCESS | 32464 | __startTimestamp1467830337463__endTimestamp 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | ------- Summary: start ------- 11:38:57 INFO - PROCESS | 32464 | Number of tests: 14 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:4.62 (4.1%) stddev-sans-first:3.35 11:38:57 INFO - PROCESS | 32464 | Values: 102.0 112.0 105.0 115.0 113.0 113.0 117.0 112.0 115.0 112.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:149.00 stddev:22.28 (15.0%) stddev-sans-first:23.44 11:38:57 INFO - PROCESS | 32464 | Values: 152.0 121.0 147.0 170.0 120.0 145.0 151.0 124.0 186.0 124.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:2.50 (1.5%) stddev-sans-first:2.60 11:38:57 INFO - PROCESS | 32464 | Values: 164.0 164.0 166.0 164.0 165.0 166.0 172.0 164.0 164.0 164.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:36.24 (47.7%) stddev-sans-first:38.35 11:38:57 INFO - PROCESS | 32464 | Values: 87.0 75.0 76.0 146.0 77.0 76.0 75.0 75.0 176.0 76.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.50 stddev:29.20 (34.2%) stddev-sans-first:30.16 11:38:57 INFO - PROCESS | 32464 | Values: 85.0 85.0 142.0 86.0 85.0 87.0 143.0 87.0 86.0 153.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 11:38:57 INFO - PROCESS | 32464 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 119.0 117.0 118.0 118.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 11:38:57 INFO - PROCESS | 32464 | Values: 147.0 149.0 148.0 149.0 147.0 148.0 148.0 148.0 148.0 149.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:38:57 INFO - PROCESS | 32464 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.20 (3.9%) stddev-sans-first:2.29 11:38:57 INFO - PROCESS | 32464 | Values: 55.0 56.0 55.0 62.0 54.0 56.0 57.0 55.0 56.0 56.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 11:38:57 INFO - PROCESS | 32464 | Values: 61.0 63.0 61.0 62.0 63.0 62.0 62.0 63.0 63.0 62.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:3.23 (4.2%) stddev-sans-first:3.28 11:38:57 INFO - PROCESS | 32464 | Values: 75.0 79.0 75.0 83.0 76.0 75.0 75.0 76.0 81.0 82.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:127.00 stddev:26.17 (20.6%) stddev-sans-first:27.66 11:38:57 INFO - PROCESS | 32464 | Values: 127.0 122.0 119.0 120.0 127.0 132.0 121.0 122.0 206.0 136.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:160.00 stddev:1.51 (0.9%) stddev-sans-first:1.48 11:38:57 INFO - PROCESS | 32464 | Values: 161.0 158.0 159.0 160.0 158.0 159.0 162.0 160.0 157.0 160.0 11:38:57 INFO - PROCESS | 32464 | 11:38:57 INFO - PROCESS | 32464 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:1.75 (2.7%) stddev-sans-first:1.86 11:38:57 INFO - PROCESS | 32464 | Values: 65.0 66.0 65.0 63.0 66.0 64.0 67.0 67.0 63.0 62.0 11:38:57 INFO - PROCESS | 32464 | -------- Summary: end -------- 11:38:57 INFO - PROCESS | 32464 | 11:38:58 INFO - TEST-INFO | 32464: exit 0 11:38:58 INFO - TEST-OK | kraken | took 62206ms 11:38:58 INFO - SUITE-END | took 1173s 11:38:58 INFO - Completed test suite (00:19:34) 11:38:58 INFO - javascript benchmark 11:38:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7408.542343250887, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.937661246775, 3164.5886034815485, 3184.1402821238257, 3208.967910320896, 3217.8551965161564, 5381.327334083239, 5451.400345961946, 5467.863303417412, 5504.504594586487, 5515.062439385304, 5365.54392876605, 5452.4274951130155, 5543.251661025771, 5564.304461942257, 5631.7184140793, 4971.925421118695, 4987.625928055392, 5019.096562618727, 5090.083784918713, 5124.461931497195, 5007.774650140753, 5158.458361872005, 5200.817971371002, 5209.895802083956, 5225.503577160163, 4835.347228124193, 4953.257011448276, 4985.626078044161, 5025.673331233458, 5059.468755780626, 4998.175301075318, 5013.147764879943, 5013.974930125362, 5018.698878067327, 5043.596512279046, 4985.903101317705, 4989.65072444929, 4997.725125118117, 5010.448850626428, 5050.520200580976, 5419.756110974976, 5454.781808727646, 5470.972645136749, 5498.615096943216, 5546.805861794818, 5911.674857882815, 5919.467247947706, 5920.141579470996, 5922.58541902067, 5931.317898441691, 5717.799877004327, 5953.315368732608, 5972.940270597282, 5973.402659734035, 5974.880502389971, 5444.836654900319, 5471.042567550663, 5478.616496845222, 5483.8080667176855, 5492.505674489235, 5999.400059994053, 6004.159417681528, 6004.699765011819, 6006.069059295729, 6007.729652165663, 5598.748056337475, 5695.946249943774, 5700.714964251771, 5754.309482862083, 5757.91363129545, 5899.587028908021, 5945.078512830518, 5954.583179177503, 5964.7315870785915, 5971.552133589998, 5697.316322041299, 5783.219265399117, 5794.5364370851075, 5888.057910734262, 5896.793612223637, 5779.104238842986, 5856.209411729447, 5914.497267732205, 5921.289445266596, 5953.791617293374, 4435.489918659331, 4446.577575130357, 4476.865694029184, 4492.101579684011, 4492.528284530143, 3999.0, 4009.1580768038457, 4020.6582440492884, 4022.597740225954, 4037.4347591337237, 5484.122540393598, 5582.134769110794, 5660.85847853807, 5662.37713851476, 5670.5180059695385, 5919.230500035054, 5958.910616340759, 5989.9101513477335, 5997.640141591519, 6049.516038716892, 5667.716614169275, 5673.347565030074, 5674.205611214434, 5676.375598684142, 5697.059985102412, 4915.459299477055, 4938.827141050046, 4978.800847966113, 5113.488651134857, 5144.819931302462, 5973.820785376446, 6076.179715738407, 6111.3287157086725, 6123.663198524124, 6125.203723515914, 5875.3243377012195, 5885.55858310637, 5892.204552385545, 5903.26209223847, 5961.642301461926, 5941.554383421174, 5981.730822112929, 6050.30421501533, 6084.6349219047, 6124.326324104434, 5696.629719068247, 5735.8852822944145, 5774.855628609318, 5788.942110579009, 5825.70871456434, 5811.331696854916, 5893.057110862242, 5900.291964964232, 5916.437938395846, 5934.9613817580885, 5575.693336866511, 5746.885062298647, 5750.482456578928, 5754.338251101177, 5778.653280803165, 5740.90922724681, 5768.134779783066, 5773.16289138081, 5776.797812076557, 5806.129080637938, 5663.292088488939, 5684.63049901755, 5706.372299047184, 5718.51392631631, 5721.828345149652, 5572.888542229051, 5697.8860422790485, 5796.739146738322, 5806.361300256884, 5829.183914251923, 5642.830715078554, 5647.7176141193595, 5649.2373529574625, 5696.088625819849, 5706.828795136153], "value": 5429.079810812496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.2273419516555, 588.9646621202727, 622.7477871462058, 643.0643413832873, 688.5317983771033, 38727.22545549087, 42287.365689514605, 42629.360559591594, 42640.573594264046, 42719.0, 42748.358774618406, 42752.07615657295, 43143.35284970728, 43197.56802431975, 43488.56511434885, 8668.52323122228, 8811.251043661296, 8845.071267516914, 8882.86675699865, 8885.2447541959, 8659.783505412384, 8728.083551227124, 8735.825283494327, 8744.562771861381, 8745.556983097782, 8683.826323473526, 8709.25971292441, 8750.256228220609, 8767.649294028231, 8829.646814127427, 8683.34874884383, 8717.0, 8734.650613975433, 8737.563121843914, 8741.606627701769, 8710.608022638997, 8802.0, 8813.07462716412, 8814.382993190478, 8825.382223244376, 40274.194516109514, 40415.797921010504, 40484.59515404838, 40623.59376406228, 40630.79684601558, 3481.216726236602, 3630.5280313559333, 3639.1993761372455, 3653.1049892776173, 4053.9594604053877, 31478.527822082688, 31932.0, 32197.839010804797, 32209.1947701307, 32210.83894580512, 4280.59334363235, 4357.4988876279, 4364.432623758891, 4443.955560444387, 4519.073589914093, 327635.0, 328696.0, 329324.0, 329565.0, 330225.0, 55445.72277138669, 55623.443765561824, 55677.72161139168, 56025.43974560202, 56072.0, 35492.645073548934, 36456.63543364585, 36473.817630911675, 38271.42592861054, 59811.0, 16919.40782072646, 16952.915235423745, 17076.316947322215, 17144.142792860555, 17171.227294771765, 12215.816762748565, 12251.0, 12322.876771232352, 12390.62828115158, 12443.502259909683, 19368.225270989285, 19488.8051119487, 19495.512612184524, 19522.511937201685, 19563.0, 7289.671964761598, 7391.556506609621, 7425.9574277034335, 7487.5507469552, 7583.810404739816, 939.2673714502699, 1065.0201814330835, 1079.2768844873797, 1108.8203879877726, 1182.822576613515, 32882.67117328796, 32963.66540227581, 33169.50245746316, 33273.0, 33676.66323336784, 1070.539667942792, 1087.2932593814085, 1129.5877004893155, 1144.5650652752067, 1148.2364227788428, 16874.74687879683, 17212.655746884993, 17235.482935511955, 17272.22274997628, 17326.826731732523, 591273.0, 627564.0, 635497.0, 641182.0, 643444.0, 57637.0, 58192.0, 58529.0, 63634.0, 63679.68160159169, 1364.740699267136, 1377.3319939829375, 1385.8752712255744, 1389.9930500347434, 1396.1762560089596, 31490.0, 34369.62943406425, 34558.0, 34806.65193348034, 35113.297734045686, 53707.0, 53918.73040634772, 53945.19082213849, 54097.72951135219, 54131.45868541264, 559195.0, 563180.0, 564299.0, 564319.0, 564627.0, 43304.0, 44694.0, 44707.0, 44839.775801120784, 47434.52565474301, 47260.527394725614, 47881.52118478771, 48437.5156248433, 48530.5146948526, 48914.266286005026, 40561.18877622372, 40907.59092409038, 42179.57820421879, 42392.1521569573, 43377.3493397593, 41533.37699934443, 41849.79075104605, 41852.0, 42322.36516452194, 42546.0, 41158.38262426006, 41423.1715365697, 42318.36522452104, 42326.36510452407, 44746.77626611976, 41352.37971430491, 43939.78030109829, 44400.333994990746, 48487.0, 48503.75748121237, 32129.35741285208, 33302.333953321286, 35530.46704299489, 35895.461568075974, 35927.64072359243], "value": 20764.519899800067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.8930544100373, 390.6620773031329, 391.1180288449546, 398.998005009975, 416.77285879195836, 13829.446822127104, 18427.262909483623, 19345.61308773824, 19824.60350792985, 19982.20071197154, 19035.428937131874, 19090.140943657534, 19299.421017369466, 20196.899015504903, 20261.290854820083, 5682.829515114553, 5799.681017544033, 5800.535957123441, 5845.0, 5889.8822023559505, 5537.750801213935, 5795.594308398414, 5816.156657284691, 5827.184194212814, 5860.560457965648, 5783.942160578404, 5808.651480911138, 5827.592068555182, 5870.236869206997, 5925.970370148165, 5915.378885217055, 5948.524118070565, 6061.727222275008, 6165.106059621375, 6187.907181392283, 4985.5513003829465, 5267.28891599633, 5318.0, 6013.308469525973, 6059.545534084918, 14161.504347347793, 14206.289685515787, 14298.0, 21155.47111322214, 22031.228906988337, 2345.8006069484113, 2396.341006223285, 2478.8388754730886, 2788.3168623687325, 2864.0, 10163.288569800043, 10206.336588121823, 10517.263791534595, 10566.260361774679, 10745.0, 1979.2775636892432, 1995.9201631934704, 2005.177877070394, 2042.5710600773855, 2092.686097085434, 79998.20001800024, 80859.5957020211, 81399.59300203461, 81711.9999999994, 82632.17367826364, 11016.669499915015, 11054.447277636085, 11448.828267575993, 11555.88444115565, 11677.708057298636, 15390.0, 15423.0, 15463.226838658022, 15524.456644017406, 15547.922260388626, 7914.960425197953, 7965.402594805413, 8015.47899386538, 8042.638081286239, 8263.380246481538, 7439.218882017419, 7449.925500744923, 7528.887066694004, 7636.121845987783, 7736.988383020455, 4333.414988976448, 4477.238869392211, 4694.671373003857, 4862.124817532807, 4924.064427758714, 1984.28565716342, 2024.6962955556785, 2029.8173164415273, 2051.4050925231813, 2052.271443637517, 931.8136372725482, 937.3953799799092, 977.1645243317004, 979.1872745621117, 1059.3590877519143, 19582.412527624194, 19882.50293742639, 19955.401337959884, 19956.0, 20124.798752012586, 991.5637119667323, 999.7250756042001, 1009.9899001010043, 1033.715728174743, 1047.8009178256107, 10553.366797991992, 11053.889461105286, 11064.28082174672, 11097.38964356952, 11183.384913829817, 351052.0, 457332.0, 463530.0, 492550.0, 494523.0, 64925.67537162379, 102461.0, 102643.0, 103758.48120759348, 104160.0, 994.8457989011715, 997.4214955325893, 1052.3948729480733, 1066.7973085113804, 1067.1196263082988, 14914.701705966037, 17080.23138958775, 17143.571410714332, 17609.20758565842, 18826.0, 44934.55065449434, 45479.772601136785, 45561.31658025199, 46076.7696161517, 46205.37946205353, 59328.40671593229, 60477.39522604718, 60581.39418605757, 62563.68718156562, 62819.37180628135, 7052.400545953446, 7438.033055702724, 8781.385303028983, 9016.639334426813, 9104.590293436679, 12444.626661200178, 12870.16343937641, 12903.0, 13141.737165256833, 13234.205947643171, 5692.971535142297, 9750.561224744763, 10172.84740728875, 10979.890201098206, 11187.160962927976, 11060.446977651247, 11106.833397498882, 11181.273217240854, 11220.495077721685, 11601.477933492844, 11249.381284029458, 11262.662120136409, 11271.661850144508, 11458.656240312805, 11524.0, 7394.926050739639, 7509.6245187739305, 7653.081630204411, 7660.119086305146, 7674.8081297968, 11081.667549973514, 11242.269252498561, 11403.091557669639, 11496.655100347003, 11499.0], "value": 9126.93901069283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.8226612806466, 1490.6198919275582, 1653.5618061213781, 1814.3921786201622, 1816.0102744004507, 7991.9600401997905, 8269.917300827005, 8649.524276164808, 9298.72103836885, 9355.158035776787, 8262.256396924291, 8511.914880851189, 8521.829563408728, 8528.616212270446, 8613.741587752362, 2268.319504148753, 2271.4207876991345, 2287.63397856343, 2294.105298933417, 2306.215886598556, 2251.966220506694, 2283.668868014137, 2302.4128847143957, 2314.3866875278063, 2322.837401381904, 2280.1677387753516, 2308.861468311898, 2310.5378924215142, 2312.8612283262974, 2325.6744055832114, 2265.365697604673, 2270.750217476076, 2272.3523795718224, 2275.920342788003, 2293.9770602294016, 2221.8222542196586, 2241.0, 2245.494763678176, 2246.1576908659254, 2251.0, 8543.572821358906, 8570.74287771368, 8592.8711069334, 8648.481091134552, 8649.740507784776, 5384.300040994684, 5498.532624726863, 5509.779608815643, 5524.944750552483, 5534.308211473566, 3370.713489353408, 3460.602030766469, 3519.8240087995496, 3576.3204991051616, 3584.318979393907, 1230.655416483386, 1239.9442025108892, 1252.0984890878644, 1266.5820279307807, 2163.7728038555883, 12624.116311858174, 12635.368231588476, 12663.240205587603, 12700.364981750876, 12771.808422873664, 4548.317752337176, 4557.931631025537, 4648.163330600524, 4768.213244814636, 4779.784909679072, 10062.345947513388, 10117.595296188218, 10129.594816207416, 10158.695239142837, 10159.288849780445, 5447.673139611636, 5457.45425457459, 5459.617826752089, 5464.480874316933, 5476.0, 4165.042040330741, 4801.327814106028, 4865.756712164449, 5032.220005899091, 5069.264956581275, 3882.8835134946, 3918.74528155669, 3936.7834769087403, 3973.324534829086, 4005.319095753729, 1148.7817314710178, 1170.0756402442146, 1176.8823117688162, 1185.958491452795, 1190.9166358355005, 977.9780129764413, 982.3221976835961, 1001.2840818814583, 1009.2834087797746, 1018.1752780248023, 6210.31686514483, 6215.906761398583, 6265.624062556261, 6294.842628934313, 6487.837804054936, 431.3185167435444, 434.42004923426947, 434.5979968529098, 436.3563743478344, 443.96448284137193, 4251.511076226212, 4319.913601727948, 4329.177456283296, 4340.435743353344, 4348.456442944632, 11191.440427978569, 11392.487338069806, 11575.305481671126, 11595.362255075883, 11600.6519804406, 10576.471176441148, 11327.697314808738, 11385.658430247106, 11461.426928653535, 11469.713257168638, 8041.6381262843315, 8371.832563348698, 8445.535495547681, 8467.195616416431, 8478.406511544134, 6152.538559608137, 6348.682565871781, 6427.646479443675, 6482.611043337415, 6575.079488871657, 10411.531481083219, 10535.315204511682, 10537.736556586147, 10568.788624227625, 10585.470726463493, 10202.132818710492, 10481.0, 10504.369737815756, 10528.210384221062, 10566.207534434794, 7944.801379965547, 7977.361811055218, 8122.918770812216, 8387.07742148351, 8721.520316382659, 8959.552022398724, 9036.05121462237, 9103.817923641622, 9107.408018478778, 9149.86275205859, 7825.0, 7943.24539168778, 8047.0745864226365, 8177.182281771775, 8199.180081991753, 7765.262300081483, 7830.373570114263, 7969.760907172794, 7971.362291016821, 7993.920060799318, 7399.149097853816, 7449.180590135189, 7470.701171953278, 7552.811179720551, 7584.886226706714, 5331.946680533145, 5396.406395296436, 5417.620766546304, 5445.428230035789, 5586.190002449704, 5561.360443548881, 5562.694051827189, 5725.141228815711, 5765.740541675551, 5794.507466865195], "value": 4673.378253045551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.828415082082, 337.5813990651592, 338.6004514672686, 339.4907638542187, 340.3550272234118, 5557.110862262039, 5619.297587801525, 5685.857853553658, 5756.712164391779, 5800.361960184382, 5619.887602247953, 5626.915596266049, 5693.829185124442, 5720.713964301779, 5736.397678243787, 4394.450693663292, 4412.227860124482, 4429.6899217054815, 4451.243288640939, 4460.375547423363, 4342.088161486092, 4393.860769599242, 4398.890027749316, 4424.77876106195, 4443.866683999469, 4306.224879521685, 4311.1593239318345, 4329.653627709776, 4361.9345709814215, 4435.246008178601, 4336.6530677545725, 4376.584224498668, 4400.7579583122915, 4401.427814384109, 4417.31531612599, 3780.451834484012, 3858.8649397271242, 3871.361225397834, 3879.3405121129476, 3908.9609103908883, 5403.406364944848, 5443.237946687467, 5474.178873169017, 5516.834494965157, 5581.5813813963705, 5018.272350509155, 5052.242163675442, 5052.898942021176, 5065.645404821664, 5099.949000509984, 5752.539796816286, 5907.5864689471755, 5943.821685349447, 5977.641341519523, 6015.54883383748, 4277.97861010696, 4296.398504209413, 4305.526392096866, 4310.396544483743, 4310.892227694301, 6172.0, 6193.628382297076, 6237.469815065725, 6256.812295631138, 6256.937430625681, 4017.959820401817, 4244.38456423823, 4287.914241715148, 4299.720518166309, 4329.480462344539, 4324.654027677778, 4351.956480435155, 4372.453443319585, 4377.6497880170145, 4378.211921854033, 4984.675996060245, 4994.076095922193, 5021.422536408287, 5036.949630503648, 5058.54473097423, 5739.655620662774, 5764.587676019402, 5884.411558844081, 5934.703264836741, 5974.3726908674835, 1483.4288798812536, 1503.5414198669512, 1514.6516301250554, 1515.5983664328962, 1523.2688309611449, 898.9685361012333, 932.8600709893434, 950.695777351241, 953.2850362228329, 957.7940742740344, 4950.2079667253065, 4990.251462280687, 5023.522765337287, 5025.623078269071, 5135.613384386194, 5336.386315573681, 5369.5972802040005, 5374.811881584125, 5393.894251678396, 5428.972855135699, 4823.710577365369, 5024.995000999815, 5080.882205914693, 5082.796688132507, 5084.949030581695, 2851.519178314838, 2885.697001814779, 2888.3789985153294, 2891.4361699468823, 2901.8537677617646, 5381.112116500812, 5383.192521121863, 5388.865278367994, 5475.890482190413, 5535.121736696976, 5376.946230537645, 5787.363390027093, 6280.623162610258, 6287.339829317947, 6299.401556852092, 6316.842078948063, 6356.904646430307, 6403.423691867662, 6408.903866442007, 6415.615063096229, 5984.581079324405, 6107.877842443215, 6135.53983451234, 6163.876722465615, 6216.2540495140875, 6081.84444955457, 6082.817515474543, 6109.816705498843, 6110.69446527663, 6139.465133716571, 6081.756729730938, 6273.686315684106, 6327.90508142369, 6339.936600634119, 6403.231612206565, 4286.142771445661, 4297.119090586485, 4303.505096913895, 4319.33050377192, 4347.978225117158, 5915.556333275108, 5985.940140598538, 6122.204113465221, 6192.473639740672, 6196.721147548281, 5913.29040515141, 5952.0, 5957.765837810821, 5993.160957465871, 6051.909221361595, 5824.563157763269, 5921.2006379138265, 5922.89737143308, 5936.050231962865, 5955.880882382415, 5663.292088488939, 5824.835032993334, 5826.533877289722, 5830.9416905832095, 5904.675242861512, 5961.165436838933, 6036.154938308552, 6084.904717150778, 6115.510759139169, 6123.2652081750475, 5599.664020158803, 5830.912536311874, 5836.416358364299, 5841.357450680507, 5867.946218823548], "value": 4433.177388391716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.9419246460284, 780.1379475679374, 784.6429874407145, 802.0255389701515, 871.6252011634998, 13156.473741050359, 14000.439982400718, 14009.0, 14077.296135193224, 14192.716145677081, 14600.0, 14774.704505909902, 14922.477713280037, 15566.844331556682, 15600.687986240267, 814.6944895664126, 829.0838623321233, 832.7335252719132, 833.5082301442147, 836.3560058754755, 784.8273379856422, 800.2077942836609, 803.4897839871694, 804.3364224514769, 806.4677312973439, 850.0394554153828, 850.6639877248483, 852.7484392104313, 853.3088198559155, 853.8761879527495, 837.2548431895588, 840.3739214285366, 842.9957850210741, 843.9789005274856, 847.0428415890004, 614.7663887722681, 615.4276522833762, 616.6176970278456, 617.5245061302817, 621.4158690830604, 14513.637159071002, 14522.346494407671, 14659.0, 14702.338394772261, 14708.779368309484, 15191.772123418157, 15235.771463428058, 15235.771463428058, 15238.847611523965, 15319.693606127816, 12500.24998500093, 12622.495100195982, 12736.095558044046, 12757.107002509829, 13065.934670326587, 3896.902577435558, 3907.902302442433, 3943.7239393242485, 4019.356902895552, 4062.9593704063172, 77902.0, 78054.60972695157, 78292.0, 79907.60046199789, 80459.79310310408, 11283.210175287815, 11353.829692554618, 11520.596779112859, 11728.88271117295, 12015.699607509881, 21853.453663658216, 21884.562308753735, 22025.22911698083, 22056.88971555132, 22083.889580551993, 8704.390692651454, 8726.520041397784, 8899.644014239359, 8962.775930601787, 9215.124563166488, 4894.290327902434, 4897.289892965571, 4921.384826896638, 4923.630727695438, 5059.442215188311, 3413.2661477782394, 3504.141485336058, 3544.078539579728, 3550.3076900004253, 3561.9643803562153, 601.7683191971123, 606.6572386601556, 613.7606333529927, 615.0436071908225, 621.869407424446, 756.2324240895496, 789.5144486141097, 790.1229635105029, 800.7517669522466, 822.2188920525525, 10013.799724005625, 10259.127974122133, 10594.728632563987, 10627.628033018962, 10835.83746243807, 644.9032645103272, 720.7837648705367, 775.9262870027338, 805.1746959366697, 808.458332916947, 5059.342285502935, 5197.558207552324, 5246.606504512177, 5274.97362513185, 5286.920696189561, 95771.0, 95935.0, 100056.4997175024, 116873.0, 117051.0, 84819.0, 98335.50832245935, 99519.50240248753, 101023.0, 101153.0, 82027.58986205031, 82081.0, 83240.58379708184, 84482.15517844865, 88107.99999999872, 10262.538185781807, 10436.0, 10665.200109991627, 10747.731306717082, 10825.891741082489, 48229.75885120552, 48810.5118948806, 49913.0, 50057.24914126218, 50520.24219636635, 73976.2602373991, 77062.6146869262, 77615.61192194003, 78247.21752782399, 79434.6028269855, 12974.740505190031, 13126.60620181396, 13252.20486770797, 13437.731245374842, 13909.791353129913, 15622.0, 15680.0, 15816.683666326839, 16020.519384418487, 16106.355745770506, 14092.154470731788, 14194.787078193629, 14238.430462781787, 14539.709205816036, 15115.31981060833, 14247.64380890486, 14391.784123238369, 14652.487162949246, 14677.779833302295, 14969.176695281863, 14055.0, 14534.345954431865, 14665.340059697553, 14715.779263311273, 14741.778873317124, 11105.111680231319, 11393.560549684908, 11400.657980260274, 11959.940200298943, 12085.516579336729, 11300.43497825089, 11583.8262426062, 11698.649040528799, 12408.107932995103, 12754.298513581842], "value": 7755.925819528841, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 105.0, 115.0, 113.0, 113.0, 117.0, 112.0, 115.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 147.0, 170.0, 120.0, 145.0, 151.0, 124.0, 186.0, 124.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 164.0, 165.0, 166.0, 172.0, 164.0, 164.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 76.0, 146.0, 77.0, 76.0, 75.0, 75.0, 176.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 142.0, 86.0, 85.0, 87.0, 143.0, 87.0, 86.0, 153.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 62.0, 54.0, 56.0, 57.0, 55.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 75.0, 83.0, 76.0, 75.0, 75.0, 76.0, 81.0, 82.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 119.0, 120.0, 127.0, 132.0, 121.0, 122.0, 206.0, 136.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 159.0, 160.0, 158.0, 159.0, 162.0, 160.0, 157.0, 160.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 63.0, 66.0, 64.0, 67.0, 67.0, 63.0, 62.0], "value": 64.8, "unit": "score"}]}]} 11:38:58 INFO - Return code: 0 11:38:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:58 ERROR - # TBPL SUCCESS # 11:38:58 INFO - Running post-action listener: _resource_record_post_action 11:38:58 INFO - ##### 11:38:58 INFO - ##### Finished run-tests step (success) 11:38:58 INFO - ##### 11:38:58 INFO - Running post-run listener: _resource_record_post_run 11:38:58 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 551583744; Read time: 0; Write time: 658484 11:38:58 INFO - TinderboxPrint: CPU usage
13.4% 11:38:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:38:58 INFO - TinderboxPrint: I/O write bytes / time
551,583,744 / 658,484 11:38:58 INFO - TinderboxPrint: CPU idle
8,227.6 (86.6%) 11:38:58 INFO - TinderboxPrint: CPU user
1,215.3 (12.8%) 11:38:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256237568; Read time: 0; Write time: 337404 11:38:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294731776; Read time: 0; Write time: 321080 11:38:59 INFO - Running post-run listener: _upload_blobber_files 11:38:59 INFO - Blob upload gear active. 11:38:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:38:59 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'] 11:38:59 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 11:38:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:00 INFO - (blobuploader) - INFO - Done attempting. 11:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:04 INFO - (blobuploader) - INFO - Done attempting. 11:39:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:39:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:05 INFO - (blobuploader) - INFO - Done attempting. 11:39:05 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:05 INFO - Return code: 0 11:39:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6086d6ea2bf8fbca2aac4f76d4385d1bbc622238df23c2734d6ade58b450ac0dea56b2deff4deac8463874c9a1da0ad6ea6039246bae99cc6f5133e8148f8e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18c66698005040c94e8bfd41afa3b87f138fb7372a2c598511b8142c60419d4e5ffde90d65a92ef76d0da99791a10c1aeff0369ff3760a0ec907601ff0058e9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bbbc5ccc9eb0e827f0feb2577f92b4bd823b5775faf1b2417e0773335d3d48fab9d70c20bc64cc63cbda6ccc06fa58d25474d767627b47d621f12424eaa6ed"} 11:39:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:05 INFO - Contents: 11:39:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6086d6ea2bf8fbca2aac4f76d4385d1bbc622238df23c2734d6ade58b450ac0dea56b2deff4deac8463874c9a1da0ad6ea6039246bae99cc6f5133e8148f8e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18c66698005040c94e8bfd41afa3b87f138fb7372a2c598511b8142c60419d4e5ffde90d65a92ef76d0da99791a10c1aeff0369ff3760a0ec907601ff0058e9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bbbc5ccc9eb0e827f0feb2577f92b4bd823b5775faf1b2417e0773335d3d48fab9d70c20bc64cc63cbda6ccc06fa58d25474d767627b47d621f12424eaa6ed"} 11:39:05 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:05 INFO - Copying logs to upload dir... 11:39:05 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.586656 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-06 11:39:04.094162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 11:39:04.097953) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467828731.204701-737714826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6086d6ea2bf8fbca2aac4f76d4385d1bbc622238df23c2734d6ade58b450ac0dea56b2deff4deac8463874c9a1da0ad6ea6039246bae99cc6f5133e8148f8e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18c66698005040c94e8bfd41afa3b87f138fb7372a2c598511b8142c60419d4e5ffde90d65a92ef76d0da99791a10c1aeff0369ff3760a0ec907601ff0058e9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bbbc5ccc9eb0e827f0feb2577f92b4bd823b5775faf1b2417e0773335d3d48fab9d70c20bc64cc63cbda6ccc06fa58d25474d767627b47d621f12424eaa6ed"} build_url:https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/DaEhCmTYR8ahunEWfyexhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6086d6ea2bf8fbca2aac4f76d4385d1bbc622238df23c2734d6ade58b450ac0dea56b2deff4deac8463874c9a1da0ad6ea6039246bae99cc6f5133e8148f8e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18c66698005040c94e8bfd41afa3b87f138fb7372a2c598511b8142c60419d4e5ffde90d65a92ef76d0da99791a10c1aeff0369ff3760a0ec907601ff0058e9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bbbc5ccc9eb0e827f0feb2577f92b4bd823b5775faf1b2417e0773335d3d48fab9d70c20bc64cc63cbda6ccc06fa58d25474d767627b47d621f12424eaa6ed"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 11:39:04.123440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:39:04.123902) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467828731.204701-737714826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 11:39:04.207549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 11:39:04.207873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 11:39:04.208239) ========= ========= Total master_lag: 0.15 =========