builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1468962420.51 results: success (0) buildid: 20160719113022 builduid: 60789ac25b8e4bd1955472e93cba70b6 revision: d1eef136f2523f1726a16c48eace3df02766ac01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.513653) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.514088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.514368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.529274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.529758) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 14:07:00-- 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% 20.4M=0.001s 2016-07-19 14:07:00 (20.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.720351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.720681) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.771150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:00.771529) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d1eef136f2523f1726a16c48eace3df02766ac01 --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 d1eef136f2523f1726a16c48eace3df02766ac01 --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=74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 14:07:00,872 truncating revision to first 12 chars 2016-07-19 14:07:00,872 Setting DEBUG logging. 2016-07-19 14:07:00,872 attempt 1/10 2016-07-19 14:07:00,872 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d1eef136f252?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 14:07:01,181 unpacking tar archive at: fx-team-d1eef136f252/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:01.437829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:01.438197) ========= script_repo_revision: d1eef136f2523f1726a16c48eace3df02766ac01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:01.438628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:01.438901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 14:07:01.449882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-19 14:07:01.450288) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:01 INFO - MultiFileLogger online at 20160719 14:07:01 in /builds/slave/test 14:07:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:07:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:01 INFO - {'append_to_log': False, 14:07:01 INFO - 'base_work_dir': '/builds/slave/test', 14:07:01 INFO - 'blob_upload_branch': 'Fx-Team', 14:07:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:01 INFO - 'branch': 'Fx-Team', 14:07:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:01 INFO - 'config_files': ('talos/linux_config.py',), 14:07:01 INFO - 'default_actions': ('clobber', 14:07:01 INFO - 'read-buildbot-config', 14:07:01 INFO - 'download-and-extract', 14:07:01 INFO - 'populate-webroot', 14:07:01 INFO - 'create-virtualenv', 14:07:01 INFO - 'install', 14:07:01 INFO - 'run-tests'), 14:07:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:01 INFO - 'download_minidump_stackwalk': True, 14:07:01 INFO - 'download_symbols': 'ondemand', 14:07:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:01 INFO - 'installer_path': 'installer.exe', 14:07:01 INFO - 'log_level': 'info', 14:07:01 INFO - 'log_name': 'talos', 14:07:01 INFO - 'log_to_console': True, 14:07:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:01 INFO - 'opt_config_files': (), 14:07:01 INFO - 'pip_index': False, 14:07:01 INFO - 'sps_profile': False, 14:07:01 INFO - 'sps_profile_interval': 0, 14:07:01 INFO - 'suite': 'dromaeojs', 14:07:01 INFO - 'system_bits': '32', 14:07:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:01 INFO - 'title': 'talos-linux64-ix-042', 14:07:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:01 INFO - 'use_talos_json': True, 14:07:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:01 INFO - 'work_dir': 'build'} 14:07:01 INFO - ##### 14:07:01 INFO - ##### Running clobber step. 14:07:01 INFO - ##### 14:07:01 INFO - Running pre-action listener: _resource_record_pre_action 14:07:01 INFO - Running main action method: clobber 14:07:01 INFO - rmtree: /builds/slave/test/build 14:07:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:02 INFO - Running post-action listener: _resource_record_post_action 14:07:02 INFO - ##### 14:07:02 INFO - ##### Finished clobber step (success) 14:07:02 INFO - ##### 14:07:02 INFO - ##### 14:07:02 INFO - ##### Running read-buildbot-config step. 14:07:02 INFO - ##### 14:07:02 INFO - Running pre-action listener: _resource_record_pre_action 14:07:02 INFO - Running main action method: read_buildbot_config 14:07:02 INFO - Using buildbot properties: 14:07:02 INFO - { 14:07:02 INFO - "project": "", 14:07:02 INFO - "product": "firefox", 14:07:02 INFO - "script_repo_revision": "production", 14:07:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:07:02 INFO - "repository": "", 14:07:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:07:02 INFO - "buildid": "20160719113022", 14:07:02 INFO - "pgo_build": "True", 14:07:02 INFO - "basedir": "/builds/slave/test", 14:07:02 INFO - "buildnumber": 302, 14:07:02 INFO - "slavename": "talos-linux64-ix-042", 14:07:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:07:02 INFO - "platform": "ubuntu64_hw", 14:07:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:07:02 INFO - "branch": "fx-team", 14:07:02 INFO - "repo_path": "integration/fx-team", 14:07:02 INFO - "revision": "d1eef136f2523f1726a16c48eace3df02766ac01", 14:07:02 INFO - "stage_platform": "linux64-pgo", 14:07:02 INFO - "builduid": "60789ac25b8e4bd1955472e93cba70b6", 14:07:02 INFO - "slavebuilddir": "test" 14:07:02 INFO - } 14:07:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:07:02 INFO - Running post-action listener: _resource_record_post_action 14:07:02 INFO - ##### 14:07:02 INFO - ##### Finished read-buildbot-config step (success) 14:07:02 INFO - ##### 14:07:02 INFO - ##### 14:07:02 INFO - ##### Running download-and-extract step. 14:07:02 INFO - ##### 14:07:02 INFO - Running pre-action listener: _resource_record_pre_action 14:07:02 INFO - Running main action method: download_and_extract 14:07:02 INFO - mkdir: /builds/slave/test/build/tests 14:07: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')]} 14:07:02 INFO - https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:07 INFO - Downloaded 1361 bytes. 14:07:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:07:07 INFO - Using the following test package requirements: 14:07:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:07:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'jsshell-linux-x86_64.zip'], 14:07:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:07:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:07:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:07 INFO - https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:09 INFO - Downloaded 24333265 bytes. 14:07:09 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'] 14:07:09 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 14:07:10 INFO - Return code: 0 14:07:10 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 14:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:10 INFO - https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:07:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:17 INFO - Downloaded 24333265 bytes. 14:07:17 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'] 14:07:17 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 14:07:18 INFO - Return code: 0 14:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:18 INFO - https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:07:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:19 INFO - Downloaded 14403317 bytes. 14:07:19 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'] 14:07:19 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 14:07:19 INFO - Return code: 0 14:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:19 INFO - https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AEC0nk9ETwSyn5vFek983w/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 14:07:21 INFO - Downloaded 60844299 bytes. 14:07:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:21 INFO - mkdir: /builds/slave/test/properties 14:07:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:21 INFO - Contents: 14:07:21 INFO - build_url:https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:07:21 INFO - Running post-action listener: _resource_record_post_action 14:07:22 INFO - Running post-action listener: set_extra_try_arguments 14:07:22 INFO - ##### 14:07:22 INFO - ##### Finished download-and-extract step (success) 14:07:22 INFO - ##### 14:07:22 INFO - ##### 14:07:22 INFO - ##### Running populate-webroot step. 14:07:22 INFO - ##### 14:07:22 INFO - Running pre-action listener: _resource_record_pre_action 14:07:22 INFO - Running main action method: populate_webroot 14:07:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:22 INFO - '--tppagecycles', 14:07:22 INFO - '7'], 14:07:22 INFO - 'tests': ['tsvgm']}}, 14:07:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['damp', 'tps']}, 14:07:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'tests': ['damp', 'tps']}, 14:07:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['dromaeo_dom']}, 14:07:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['basic_compositor_video']}, 14:07:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:07:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['a11yr', 14:07:22 INFO - 'ts_paint', 14:07:22 INFO - 'tpaint', 14:07:22 INFO - 'sessionrestore', 14:07:22 INFO - 'sessionrestore_no_auto_restore', 14:07:22 INFO - 'tabpaint']}, 14:07:22 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:22 INFO - 'ts_paint', 14:07:22 INFO - 'tpaint', 14:07:22 INFO - 'sessionrestore', 14:07:22 INFO - 'sessionrestore_no_auto_restore', 14:07:22 INFO - 'tabpaint']}, 14:07:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:07:22 INFO - 'ts_paint', 14:07:22 INFO - 'tpaint', 14:07:22 INFO - 'sessionrestore', 14:07:22 INFO - 'sessionrestore_no_auto_restore', 14:07:22 INFO - 'tabpaint']}, 14:07:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:07:22 INFO - 'ts_paint', 14:07:22 INFO - 'tpaint', 14:07:22 INFO - 'sessionrestore', 14:07:22 INFO - 'sessionrestore_no_auto_restore', 14:07:22 INFO - 'tabpaint']}, 14:07:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['a11yr', 14:07:22 INFO - 'ts_paint', 14:07:22 INFO - 'tpaint', 14:07:22 INFO - 'sessionrestore', 14:07:22 INFO - 'sessionrestore_no_auto_restore', 14:07:22 INFO - 'tabpaint']}, 14:07:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['a11yr', 14:07:22 INFO - 'ts_paint', 14:07:22 INFO - 'tpaint', 14:07:22 INFO - 'sessionrestore', 14:07:22 INFO - 'sessionrestore_no_auto_restore', 14:07:22 INFO - 'tabpaint']}, 14:07:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['tsvgx', 14:07:22 INFO - 'tsvgr_opacity', 14:07:22 INFO - 'tart', 14:07:22 INFO - 'tscrollx', 14:07:22 INFO - 'cart']}, 14:07:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:22 INFO - 'tsvgr_opacity', 14:07:22 INFO - 'tart', 14:07:22 INFO - 'tscrollx', 14:07:22 INFO - 'cart']}, 14:07:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'talos_options': ['--disable-e10s'], 14:07:22 INFO - 'tests': ['tp5o']}, 14:07:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'tests': ['tp5o']}, 14:07:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'talos_options': ['--disable-e10s', 14:07:22 INFO - '--xperf_path', 14:07:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:22 INFO - 'tests': ['tp5n']}, 14:07:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:22 INFO - 'talos_options': ['--xperf_path', 14:07:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:22 INFO - 'tests': ['tp5n']}}, 14:07:22 INFO - 'talos.zip': {'path': '', 14:07:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:22 INFO - Running post-action listener: _resource_record_post_action 14:07:22 INFO - ##### 14:07:22 INFO - ##### Finished populate-webroot step (success) 14:07:22 INFO - ##### 14:07:22 INFO - ##### 14:07:22 INFO - ##### Running create-virtualenv step. 14:07:22 INFO - ##### 14:07:22 INFO - Running pre-action listener: _resource_record_pre_action 14:07:22 INFO - Running main action method: create_virtualenv 14:07:22 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:22 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 14:07:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:22 INFO - Using real prefix '/usr' 14:07:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:24 INFO - Installing pip.................done. 14:07:24 INFO - Return code: 0 14:07:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:24 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 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:24 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 14:07:24 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 14:07:24 INFO - Using env: {'DISPLAY': ':0', 14:07:24 INFO - 'HOME': '/home/cltbld', 14:07:24 INFO - 'LANG': 'en_US.UTF-8', 14:07:24 INFO - 'LANGUAGE': 'en_US:en', 14:07:24 INFO - 'LOGNAME': 'cltbld', 14:07:24 INFO - 'MAIL': '/var/mail/cltbld', 14:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:24 INFO - 'MOZ_NO_REMOTE': '1', 14:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:24 INFO - 'NO_EM_RESTART': '1', 14:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:24 INFO - 'PWD': '/builds/slave/test', 14:07:24 INFO - 'SHELL': '/bin/bash', 14:07:24 INFO - 'SHLVL': '1', 14:07:24 INFO - 'TERM': 'linux', 14:07:24 INFO - 'TMOUT': '86400', 14:07:24 INFO - 'USER': 'cltbld', 14:07:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:24 INFO - '_': '/tools/buildbot/bin/python'} 14:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:24 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 14:07:24 INFO - Cleaning up... 14:07:24 INFO - Return code: 0 14:07:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:24 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 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:24 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 14:07:24 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 14:07:24 INFO - Using env: {'DISPLAY': ':0', 14:07:24 INFO - 'HOME': '/home/cltbld', 14:07:24 INFO - 'LANG': 'en_US.UTF-8', 14:07:24 INFO - 'LANGUAGE': 'en_US:en', 14:07:24 INFO - 'LOGNAME': 'cltbld', 14:07:24 INFO - 'MAIL': '/var/mail/cltbld', 14:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:24 INFO - 'MOZ_NO_REMOTE': '1', 14:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:24 INFO - 'NO_EM_RESTART': '1', 14:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:24 INFO - 'PWD': '/builds/slave/test', 14:07:24 INFO - 'SHELL': '/bin/bash', 14:07:24 INFO - 'SHLVL': '1', 14:07:24 INFO - 'TERM': 'linux', 14:07:24 INFO - 'TMOUT': '86400', 14:07:24 INFO - 'USER': 'cltbld', 14:07:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:24 INFO - '_': '/tools/buildbot/bin/python'} 14:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:25 INFO - Downloading/unpacking psutil>=3.1.1 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:27 INFO - Installing collected packages: psutil 14:07:27 INFO - Running setup.py install for psutil 14:07:27 INFO - building 'psutil._psutil_linux' extension 14:07:27 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 14:07:27 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 14:07:27 INFO - building 'psutil._psutil_posix' extension 14:07:27 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 14:07:27 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 14:07:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:27 INFO - Successfully installed psutil 14:07:27 INFO - Cleaning up... 14:07:28 INFO - Return code: 0 14:07:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:07:28 INFO - Using env: {'DISPLAY': ':0', 14:07:28 INFO - 'HOME': '/home/cltbld', 14:07:28 INFO - 'LANG': 'en_US.UTF-8', 14:07:28 INFO - 'LANGUAGE': 'en_US:en', 14:07:28 INFO - 'LOGNAME': 'cltbld', 14:07:28 INFO - 'MAIL': '/var/mail/cltbld', 14:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:28 INFO - 'MOZ_NO_REMOTE': '1', 14:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:28 INFO - 'NO_EM_RESTART': '1', 14:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:28 INFO - 'PWD': '/builds/slave/test', 14:07:28 INFO - 'SHELL': '/bin/bash', 14:07:28 INFO - 'SHLVL': '1', 14:07:28 INFO - 'TERM': 'linux', 14:07:28 INFO - 'TMOUT': '86400', 14:07:28 INFO - 'USER': 'cltbld', 14:07:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:28 INFO - '_': '/tools/buildbot/bin/python'} 14:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:07:31 INFO - Installing collected packages: mozsystemmonitor 14:07:31 INFO - Running setup.py install for mozsystemmonitor 14:07:31 INFO - Successfully installed mozsystemmonitor 14:07:31 INFO - Cleaning up... 14:07:31 INFO - Return code: 0 14:07:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:31 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 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:31 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 14:07:31 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 14:07:31 INFO - Using env: {'DISPLAY': ':0', 14:07:31 INFO - 'HOME': '/home/cltbld', 14:07:31 INFO - 'LANG': 'en_US.UTF-8', 14:07:31 INFO - 'LANGUAGE': 'en_US:en', 14:07:31 INFO - 'LOGNAME': 'cltbld', 14:07:31 INFO - 'MAIL': '/var/mail/cltbld', 14:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:31 INFO - 'MOZ_NO_REMOTE': '1', 14:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:31 INFO - 'NO_EM_RESTART': '1', 14:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:31 INFO - 'PWD': '/builds/slave/test', 14:07:31 INFO - 'SHELL': '/bin/bash', 14:07:31 INFO - 'SHLVL': '1', 14:07:31 INFO - 'TERM': 'linux', 14:07:31 INFO - 'TMOUT': '86400', 14:07:31 INFO - 'USER': 'cltbld', 14:07:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:31 INFO - '_': '/tools/buildbot/bin/python'} 14:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:31 INFO - Downloading/unpacking jsonschema==2.5.1 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 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 14:07:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:33 INFO - warning: no files found matching '*.txt' 14:07:33 INFO - no previously-included directories found matching 'build' 14:07:33 INFO - no previously-included directories found matching 'dist' 14:07:33 INFO - no previously-included directories found matching '.git*' 14:07:33 INFO - Installing collected packages: jsonschema, functools32 14:07:33 INFO - Running setup.py install for functools32 14:07:33 INFO - warning: no files found matching '*.txt' 14:07:33 INFO - no previously-included directories found matching 'build' 14:07:33 INFO - no previously-included directories found matching 'dist' 14:07:33 INFO - no previously-included directories found matching '.git*' 14:07:33 INFO - Successfully installed jsonschema functools32 14:07:33 INFO - Cleaning up... 14:07:33 INFO - Return code: 0 14:07:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:07:33 INFO - Using env: {'DISPLAY': ':0', 14:07:33 INFO - 'HOME': '/home/cltbld', 14:07:33 INFO - 'LANG': 'en_US.UTF-8', 14:07:33 INFO - 'LANGUAGE': 'en_US:en', 14:07:33 INFO - 'LOGNAME': 'cltbld', 14:07:33 INFO - 'MAIL': '/var/mail/cltbld', 14:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:33 INFO - 'MOZ_NO_REMOTE': '1', 14:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:33 INFO - 'NO_EM_RESTART': '1', 14:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:33 INFO - 'PWD': '/builds/slave/test', 14:07:33 INFO - 'SHELL': '/bin/bash', 14:07:33 INFO - 'SHLVL': '1', 14:07:33 INFO - 'TERM': 'linux', 14:07:33 INFO - 'TMOUT': '86400', 14:07:33 INFO - 'USER': 'cltbld', 14:07:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:33 INFO - '_': '/tools/buildbot/bin/python'} 14:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:33 INFO - Downloading/unpacking blobuploader==1.2.4 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:35 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:35 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 14:07:35 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 14:07:35 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 14:07:35 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 14:07:35 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 14:07:35 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 14:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:36 INFO - Downloading docopt-0.6.1.tar.gz 14:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:36 INFO - Running setup.py install for blobuploader 14:07:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:36 INFO - Running setup.py install for requests 14:07:37 INFO - Running setup.py install for docopt 14:07:37 INFO - Successfully installed blobuploader requests docopt 14:07:37 INFO - Cleaning up... 14:07:37 INFO - Return code: 0 14:07:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:37 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 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:37 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 14:07:37 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 14:07:37 INFO - Using env: {'DISPLAY': ':0', 14:07:37 INFO - 'HOME': '/home/cltbld', 14:07:37 INFO - 'LANG': 'en_US.UTF-8', 14:07:37 INFO - 'LANGUAGE': 'en_US:en', 14:07:37 INFO - 'LOGNAME': 'cltbld', 14:07:37 INFO - 'MAIL': '/var/mail/cltbld', 14:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:37 INFO - 'MOZ_NO_REMOTE': '1', 14:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:37 INFO - 'NO_EM_RESTART': '1', 14:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:37 INFO - 'PWD': '/builds/slave/test', 14:07:37 INFO - 'SHELL': '/bin/bash', 14:07:37 INFO - 'SHLVL': '1', 14:07:37 INFO - 'TERM': 'linux', 14:07:37 INFO - 'TMOUT': '86400', 14:07:37 INFO - 'USER': 'cltbld', 14:07:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:37 INFO - '_': '/tools/buildbot/bin/python'} 14:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:37 INFO - Running setup.py (path:/tmp/pip-7Y4USr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:37 INFO - Running setup.py (path:/tmp/pip-khuDLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:37 INFO - Running setup.py (path:/tmp/pip-rBH9Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:37 INFO - Running setup.py (path:/tmp/pip-Wo4ZEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:37 INFO - Running setup.py (path:/tmp/pip-RUSHF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:37 INFO - Running setup.py (path:/tmp/pip-sezmFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:37 INFO - Running setup.py (path:/tmp/pip-ioyTbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:37 INFO - Running setup.py (path:/tmp/pip-wi1eeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:38 INFO - Running setup.py (path:/tmp/pip-vt4PXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:38 INFO - Running setup.py (path:/tmp/pip-4BkLQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:38 INFO - Running setup.py (path:/tmp/pip-XC9WjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:38 INFO - Running setup.py (path:/tmp/pip-BzHkin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:38 INFO - Running setup.py (path:/tmp/pip-4Dwnwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:38 INFO - Running setup.py (path:/tmp/pip-esWxT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:38 INFO - Running setup.py (path:/tmp/pip-TE6X0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:38 INFO - Running setup.py (path:/tmp/pip-zhyhMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:38 INFO - Running setup.py (path:/tmp/pip-KveSUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:38 INFO - Running setup.py install for manifestparser 14:07:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:07:38 INFO - Running setup.py install for mozcrash 14:07:38 INFO - Running setup.py install for mozdebug 14:07:38 INFO - Running setup.py install for mozdevice 14:07:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Running setup.py install for mozfile 14:07:39 INFO - Running setup.py install for mozhttpd 14:07:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Running setup.py install for mozinfo 14:07:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Running setup.py install for mozInstall 14:07:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Running setup.py install for mozleak 14:07:39 INFO - Running setup.py install for mozlog 14:07:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Running setup.py install for moznetwork 14:07:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:07:39 INFO - Running setup.py install for mozprocess 14:07:39 INFO - Running setup.py install for mozprofile 14:07:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:07:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:07:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:07:40 INFO - Running setup.py install for mozrunner 14:07:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:07:40 INFO - Running setup.py install for mozscreenshot 14:07:40 INFO - Running setup.py install for moztest 14:07:40 INFO - Running setup.py install for mozversion 14:07:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:07:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:40 INFO - Cleaning up... 14:07:40 INFO - Return code: 0 14:07:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:40 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 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:40 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 14:07:40 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 14:07:40 INFO - Using env: {'DISPLAY': ':0', 14:07:40 INFO - 'HOME': '/home/cltbld', 14:07:40 INFO - 'LANG': 'en_US.UTF-8', 14:07:40 INFO - 'LANGUAGE': 'en_US:en', 14:07:40 INFO - 'LOGNAME': 'cltbld', 14:07:40 INFO - 'MAIL': '/var/mail/cltbld', 14:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:40 INFO - 'MOZ_NO_REMOTE': '1', 14:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:40 INFO - 'NO_EM_RESTART': '1', 14:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:40 INFO - 'PWD': '/builds/slave/test', 14:07:40 INFO - 'SHELL': '/bin/bash', 14:07:40 INFO - 'SHLVL': '1', 14:07:40 INFO - 'TERM': 'linux', 14:07:40 INFO - 'TMOUT': '86400', 14:07:40 INFO - 'USER': 'cltbld', 14:07:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:40 INFO - '_': '/tools/buildbot/bin/python'} 14:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:40 INFO - Running setup.py (path:/tmp/pip-1DrNdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:40 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)) 14:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:40 INFO - Running setup.py (path:/tmp/pip-QX3Y94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:40 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)) 14:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:40 INFO - Running setup.py (path:/tmp/pip-w4lC3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:40 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)) 14:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:40 INFO - Running setup.py (path:/tmp/pip-wppWNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:40 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:41 INFO - Running setup.py (path:/tmp/pip-ewYxFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:41 INFO - Running setup.py (path:/tmp/pip-o4UFiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:41 INFO - Running setup.py (path:/tmp/pip-jBLg2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:41 INFO - Running setup.py (path:/tmp/pip-Z36OXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:41 INFO - Running setup.py (path:/tmp/pip-j1H8Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:41 INFO - Running setup.py (path:/tmp/pip-8tvDvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:41 INFO - Running setup.py (path:/tmp/pip-gNNf_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:41 INFO - Running setup.py (path:/tmp/pip-iIbs0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:41 INFO - Running setup.py (path:/tmp/pip-gWGhWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:41 INFO - Running setup.py (path:/tmp/pip-HTEkmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:41 INFO - Running setup.py (path:/tmp/pip-yhoiOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:41 INFO - Running setup.py (path:/tmp/pip-9BSfV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:41 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)) 14:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:41 INFO - Running setup.py (path:/tmp/pip-tuHgue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:41 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)) 14:07:41 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)) 14:07:41 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)) 14:07:41 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)) 14:07:41 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)) 14:07:41 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)) 14:07:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:41 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 14:07:41 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 14:07:41 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 14:07:41 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 14:07:41 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 14:07:41 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 14:07:43 INFO - Downloading blessings-1.6.tar.gz 14:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:43 INFO - Installing collected packages: blessings 14:07:43 INFO - Running setup.py install for blessings 14:07:44 INFO - Successfully installed blessings 14:07:44 INFO - Cleaning up... 14:07:44 INFO - Return code: 0 14:07:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:44 INFO - Reading from file tmpfile_stdout 14:07:44 INFO - Current package versions: 14:07:44 INFO - argparse == 1.2.1 14:07:44 INFO - blessings == 1.6 14:07:44 INFO - blobuploader == 1.2.4 14:07:44 INFO - docopt == 0.6.1 14:07:44 INFO - functools32 == 3.2.3-2 14:07:44 INFO - jsonschema == 2.5.1 14:07:44 INFO - manifestparser == 1.1 14:07:44 INFO - mozInstall == 1.12 14:07:44 INFO - mozcrash == 0.17 14:07:44 INFO - mozdebug == 0.1 14:07:44 INFO - mozdevice == 0.48 14:07:44 INFO - mozfile == 1.2 14:07:44 INFO - mozhttpd == 0.7 14:07:44 INFO - mozinfo == 0.9 14:07:44 INFO - mozleak == 0.1 14:07:44 INFO - mozlog == 3.2 14:07:44 INFO - moznetwork == 0.27 14:07:44 INFO - mozprocess == 0.23 14:07:44 INFO - mozprofile == 0.28 14:07:44 INFO - mozrunner == 6.12 14:07:44 INFO - mozscreenshot == 0.1 14:07:44 INFO - mozsystemmonitor == 0.3 14:07:44 INFO - moztest == 0.7 14:07:44 INFO - mozversion == 1.4 14:07:44 INFO - psutil == 3.1.1 14:07:44 INFO - requests == 1.2.3 14:07:44 INFO - wsgiref == 0.1.2 14:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:44 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 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:44 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 14:07:44 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 14:07:44 INFO - Using env: {'DISPLAY': ':0', 14:07:44 INFO - 'HOME': '/home/cltbld', 14:07:44 INFO - 'LANG': 'en_US.UTF-8', 14:07:44 INFO - 'LANGUAGE': 'en_US:en', 14:07:44 INFO - 'LOGNAME': 'cltbld', 14:07:44 INFO - 'MAIL': '/var/mail/cltbld', 14:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:44 INFO - 'MOZ_NO_REMOTE': '1', 14:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:44 INFO - 'NO_EM_RESTART': '1', 14:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:44 INFO - 'PWD': '/builds/slave/test', 14:07:44 INFO - 'SHELL': '/bin/bash', 14:07:44 INFO - 'SHLVL': '1', 14:07:44 INFO - 'TERM': 'linux', 14:07:44 INFO - 'TMOUT': '86400', 14:07:44 INFO - 'USER': 'cltbld', 14:07:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:44 INFO - '_': '/tools/buildbot/bin/python'} 14:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 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)) 14:07:44 INFO - Cleaning up... 14:07:44 INFO - Return code: 0 14:07:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d5a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, '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': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', '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 14:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:07:44 INFO - Using env: {'DISPLAY': ':0', 14:07:44 INFO - 'HOME': '/home/cltbld', 14:07:44 INFO - 'LANG': 'en_US.UTF-8', 14:07:44 INFO - 'LANGUAGE': 'en_US:en', 14:07:44 INFO - 'LOGNAME': 'cltbld', 14:07:44 INFO - 'MAIL': '/var/mail/cltbld', 14:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:44 INFO - 'MOZ_NO_REMOTE': '1', 14:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:44 INFO - 'NO_EM_RESTART': '1', 14:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:44 INFO - 'PWD': '/builds/slave/test', 14:07:44 INFO - 'SHELL': '/bin/bash', 14:07:44 INFO - 'SHLVL': '1', 14:07:44 INFO - 'TERM': 'linux', 14:07:44 INFO - 'TMOUT': '86400', 14:07:44 INFO - 'USER': 'cltbld', 14:07:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:44 INFO - '_': '/tools/buildbot/bin/python'} 14:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:07:44 INFO - Cleaning up... 14:07:44 INFO - Return code: 0 14:07:44 INFO - Running post-action listener: _resource_record_post_action 14:07:44 INFO - Running post-action listener: _start_resource_monitoring 14:07:44 INFO - Starting resource monitoring. 14:07:44 INFO - ##### 14:07:44 INFO - ##### Finished create-virtualenv step (success) 14:07:44 INFO - ##### 14:07:44 INFO - ##### 14:07:44 INFO - ##### Running install step. 14:07:44 INFO - ##### 14:07:44 INFO - Running pre-action listener: _resource_record_pre_action 14:07:44 INFO - Running main action method: install 14:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:45 INFO - Reading from file tmpfile_stdout 14:07:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:45 INFO - Reading from file tmpfile_stdout 14:07:45 INFO - Output received: 14:07:45 INFO - Usage: mozinstall [options] installer 14:07:45 INFO - Options: 14:07:45 INFO - -h, --help show this help message and exit 14:07:45 INFO - -d DEST, --destination=DEST 14:07:45 INFO - Directory to install application into. [default: 14:07:45 INFO - "/builds/slave/test"] 14:07:45 INFO - --app=APP Application being installed. [default: firefox] 14:07:45 INFO - mkdir: /builds/slave/test/build/application 14:07:45 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'] 14:07:45 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 14:08:02 INFO - Reading from file tmpfile_stdout 14:08:02 INFO - Output received: 14:08:02 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:02 INFO - Running post-action listener: _resource_record_post_action 14:08:02 INFO - ##### 14:08:02 INFO - ##### Finished install step (success) 14:08:02 INFO - ##### 14:08:02 INFO - ##### 14:08:02 INFO - ##### Running run-tests step. 14:08:02 INFO - ##### 14:08:02 INFO - Running pre-action listener: _resource_record_pre_action 14:08:02 INFO - Running main action method: run_tests 14:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:02 INFO - Python 2.7.3 14:08:02 INFO - Return code: 0 14:08:02 INFO - grabbing minidump binary from tooltool 14:08: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')]} 14:08:02 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 0x2d583b0>, '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 0x2d592b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d59740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:02 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 14:08:02 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 14:08:02 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 14:08:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:02 INFO - Return code: 0 14:08:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:08:02 INFO - Using env: {'DISPLAY': ':0', 14:08:02 INFO - 'HOME': '/home/cltbld', 14:08:02 INFO - 'LANG': 'en_US.UTF-8', 14:08:02 INFO - 'LANGUAGE': 'en_US:en', 14:08:02 INFO - 'LOGNAME': 'cltbld', 14:08:02 INFO - 'MAIL': '/var/mail/cltbld', 14:08:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:02 INFO - 'MOZ_NO_REMOTE': '1', 14:08:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:02 INFO - 'NO_EM_RESTART': '1', 14:08:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:02 INFO - 'PWD': '/builds/slave/test', 14:08:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:02 INFO - 'SHELL': '/bin/bash', 14:08:02 INFO - 'SHLVL': '1', 14:08:02 INFO - 'TERM': 'linux', 14:08:02 INFO - 'TMOUT': '86400', 14:08:02 INFO - 'USER': 'cltbld', 14:08:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884', 14:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:02 INFO - '_': '/tools/buildbot/bin/python'} 14:08:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:08:02 INFO - mozversion application_buildid: 20160719113022 14:08:02 INFO - mozversion application_changeset: d1eef136f2523f1726a16c48eace3df02766ac01 14:08:02 INFO - mozversion application_display_name: Nightly 14:08:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:02 INFO - mozversion application_name: Firefox 14:08:02 INFO - mozversion application_remotingname: firefox 14:08:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:08:02 INFO - mozversion application_vendor: Mozilla 14:08:02 INFO - mozversion application_version: 50.0a1 14:08:02 INFO - mozversion platform_buildid: 20160719113022 14:08:02 INFO - mozversion platform_changeset: d1eef136f2523f1726a16c48eace3df02766ac01 14:08:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:08:02 INFO - mozversion platform_version: 50.0a1 14:08:02 INFO - using testdate: 1468962482 14:08:02 INFO - actual date: 1468962482 14:08:02 INFO - starting webserver on 'localhost:33950' 14:08:02 INFO - SUITE-START | Running 2 tests 14:08:02 INFO - TEST-START | dromaeo_css 14:08:02 INFO - operating with platform_type : linux_ 14:08:02 INFO - Initialising browser for dromaeo_css test... 14:08:02 INFO - TEST-INFO | started process 28504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXlWWUI/profile http://localhost:33950/getInfo.html) 14:08:06 INFO - PROCESS | 28504 | __metrics Screen width/height:1600/1200 14:08:06 INFO - PROCESS | 28504 | colorDepth:24 14:08:06 INFO - PROCESS | 28504 | Browser inner width/height: 1024/697 14:08:06 INFO - PROCESS | 28504 | __metrics 14:08:07 INFO - PROCESS | 28504 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:08:07 INFO - PROCESS | 28504 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:08 INFO - TEST-INFO | 28504: exit 0 14:08:08 INFO - Browser initialized. 14:08:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:08 INFO - TEST-INFO | started process 28585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXlWWUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:20 INFO - PROCESS | 28585 | RSS: Main: 157904896 14:08:20 INFO - PROCESS | 28585 | 14:09:12 INFO - PROCESS | 28585 | 1468962552017 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] 14:11:19 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:33950/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33950/tests/dromaeo/cssquery-ext.html) 14:11:20 INFO - PROCESS | 28585 | RSS: Main: 231976960 14:11:20 INFO - PROCESS | 28585 | 14:14:23 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:33950/tests/dromaeo/cssquery-ext.html (next: http://localhost:33950/tests/dromaeo/cssquery-jquery.html) 14:14:24 INFO - PROCESS | 28585 | RSS: Main: 247939072 14:14:24 INFO - PROCESS | 28585 | 14:17:26 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:33950/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33950/tests/dromaeo/cssquery-mootools.html) 14:17:26 INFO - PROCESS | 28585 | RSS: Main: 247107584 14:17:26 INFO - PROCESS | 28585 | 14:20:28 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:33950/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33950/tests/dromaeo/cssquery-prototype.html) 14:20:29 INFO - PROCESS | 28585 | RSS: Main: 243830784 14:20:29 INFO - PROCESS | 28585 | 14:23:31 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:33950/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33950/tests/dromaeo/cssquery-yui.html) 14:23:32 INFO - PROCESS | 28585 | RSS: Main: 199958528 14:23:32 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | Cycle 1(1): loaded http://localhost:33950/tests/dromaeo/cssquery-yui.html (next: http://localhost:33950/tests/dromaeo/cssquery-dojo.html) 14:26:35 INFO - PROCESS | 28585 | RSS: Main: 276070400 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | __start_tp_report 14:26:35 INFO - PROCESS | 28585 | _x_x_mozilla_page_load 14:26:35 INFO - PROCESS | 28585 | _x_x_mozilla_page_load_details 14:26:35 INFO - PROCESS | 28585 | |i|pagename|runs| 14:26:35 INFO - PROCESS | 28585 | |0;dojo.html;3020.1392603108116;3036.0284708893164;3058.72471477567;3062.020153550864;3073.231692076981;5224.5297923187;5283.524482796547;5301.496357846008;5362;5379.354477462705;5373.032854086273;5381.596380271476;5395.406505284425;5422.915416916613;5436.885438485111;4819.1325561398935;4870.853874383774;4880.316755654211;4886.828960986366;5046.041252162077;4956;4963;5006.2740902569285;5024.673396229234;5029.270755740416;4779.689320194177;4790.425148982127;4825.324454576362;4844.927326090094;4854.101991131652;4811.422629284508;4850.708957462528;4921.114199444099;4930.950690493085;4976.104301225778;4876.658633895629;4877.268409738532;4882.633802464794;4885.071836351118;4945.455999840015;5194.194899790538;5205.791768329263;5211.478852114796;5268.1834315681135;5288;5630.239917611111;5638.126090455986;5661.122526008476;5665.3768085510565;5687.7156142192725;5554.638948468337;5704.286964129484;5710.657360558338;5781.4507621775865;5791.391903850077;5258.237555554423;5278.2346559749;5280.841574752763;5339.919901201485;5386.299781028441;5901.232839730894;5967.16459695643;5974.462298393166;5974.701264936736;5974.954382982961;5443.945560544423;5628.493435590816;5717.056685646821;5727.312722473246;5732.828015159468;5717;5831.737571809279;5837.211976383134;5840.036393995028;5840.853978650568;5743.483086522233;5784.8264552062665;5787.855303617359;5833.387494313036;5843.03589907669;5526.917096243559;5786.132080188006;5797.188393624896;5804.390538993429;5810.360860305363;4289.592488713567;4309.224339618899;4330;4349.173657005159;4380.6057454829215;3883.359245724424;3888.572257051722;3897.512810898638;3911.7457365271166;3918.6669133123432;5207.427183009866;5341.465853414705;5384.865378365572;5385.5960802939935;5436.537894278951;5680.062789639664;5728.083506639001;5750.7987220447085;5757.251557297524;5802.47777700009;5388.407275199725;5391.676499410048;5393.514583687408;5394;5394.541463975606;4695.295705644181;4742;4756.072565849695;4809.254565542346;4843.782029808667;5884.852453771474;5916.881662366729;5939.13882487037;5939.821805345847;5983.222181116514;5707.1153971134545;5708.029634961983;5716.485516303553;5722.227499287543;5727.713614319351;5701.914471282851;5854.707264636666;5870;5888.823335299948;5903.557233207441;5654.46282603152;5655.953648575027;5658.009848276452;5659.86802639482;5660.943390566042;5672.347680016685;5750.281214848144;5767.509761670305;5775.133729940542;5782.884342313046;5442.619016668795;5579.414161513145;5621.2411324472305;5644.8306550803545;5685.20407142992;5632.5775566831835;5658.377578466283;5672.290963629546;5672.404397538364;5675.262215911905;5406.810761623325;5618.634788738719;5636.21093046982;5638.4925356718095;5644.745986430703;5502;5604.775808967595;5607.831765047055;5613.045782217115;5646.604737668324;5475.5072043516275;5517.503424691797;5575.832725018256;5576.4702353278;5579.553635709215 14:26:35 INFO - PROCESS | 28585 | |1;ext.html;611.4008271893545;618.1006635345572;636.8057742388572;639.0414378432351;669.1301308299215;43653.34519982199;45034.32448513271;45260.32109518356;48378.516214837844;48652;45633.77183114088;46426.303605445864;46575.534244657545;46580.534194658045;46702;8939.687110951101;9067.229285510739;9078.364514483988;9079.636814527412;9080.636774529012;8906.421082629608;8972.730818075435;8975.326850486206;8982.056884027148;8987.550622468883;9006.279497640206;9021.594028268712;9038;9041.276697864188;9042.050584688579;9001.95499022504;9011.279097672235;9026.097390260988;9026.097390260988;9026.86459703105;8870.645174193089;8917.777055573597;8919.464832110094;8925.375223734341;8935.32985026119;43238.78380608108;43255;43472.347914781305;43511.34732979008;43572.564274357166;3758.49260349852;3857.3828187489867;3862.4206369044587;3868.941965870514;3960.881173564798;33895.15262118442;33974.32051358959;34213.65786342129;34750;35441.64558354435;4400.339949007643;4499.347594598765;4526.23054080807;4536.364908912755;4546.704464209849;336217;337318;338202;340891;342119.2894035539;60869.39130608726;60891.69554152201;61159;61159.71881968308;61274;54473;55349;55457.72271138699;61117.69441152766;63409;15291.311890964933;15893.523194304189;15968.441104561516;16541.421050263183;16554;12351.320677362832;12406.441710123067;12409.689757755948;12429.192102513307;12444;15974.201289935456;18060.374566288836;18174.36389726353;18252.269909203747;18274.543136421697;5991.850203744942;6040.134314039018;6125.601835880653;6131.233595800525;6329.556931014785;1024.5440778853338;1038.657243109787;1049.5172220778527;1059.2743970380313;1110;34051.14872128217;34360.48459273113;34375.484367734505;34417.13957151091;34465.310693785985;1069.4813015687384;1106.80630889594;1121.7980763462492;1158.25871442277;1255.453877563263;17557.473275801745;17591.648167036845;17595.91202044007;17598.38405655796;17614.735778963324;567274;569769;570335.33490993;572096;572137;58169;58693.41306586879;58768.41231587715;58775.41224587785;58797.70601146967;1311.8229039079793;1376.4287820554357;1381.4957540497646;1392.9094608850594;1395.330241484073;31862;32545.674543255212;32876;32959.67040329662;33636.1590960228;51527.484725152266;51586.22620660768;51907.74046129745;51932.48067519276;51946.220806687175;343747;345170;345271;345379;345669;25126;28609.570856437585;43469.56530434655;46213.22334708161;47174.29238561493;48083.75958120327;50137.74931125321;50669.493305067954;51540.226896597334;52022;42484;43541.564584355016;44023.339649904636;44079.559204407546;44483.55516444794;43456.34815477834;43514.56485435232;43576.12847743091;43774.78112609417;44384;43433.3484997719;44019;44128.33807492955;44481.77759111184;44523.55476445194;37057.62942370542;38174.427383588714;38379;38981.80509097436;39261;29579.40841183207;29967;30023.399532009673;30115.698843012167;30338.54492182575 14:26:35 INFO - PROCESS | 28585 | |2;jquery.html;376.5105363028066;388.95915928827475;400.4193918817715;406.29507803960126;413.7286298222758;14340.928295358523;17395.478135655936;19458;19649.21403143876;19706.21175152994;19511.902440487815;20002.099905504252;20222.595548089066;20226.08982595783;20250.39248822534;5543.972280138593;5570.721463926808;5765.827025189251;5803.390643982384;5818.272715910512;5583.302087239095;5637;5688.203651488795;5705.48650621444;5707.229524014268;5664.235328230698;5673.290838645169;5675;6159.969200154015;6484.837879053014;6424.132742079806;6438.130852334945;6462.773802916922;6492.545521813498;6493.480521558287;5632.887342253132;5822.679752613604;5840.211571437844;5843.152742852305;5845.824625261249;13368.197908125543;13626;16318.592035199097;24691.38271543208;24751.752482475124;2298.0577963035075;2304.1129165271323;2308.803751681109;2363.3973336799177;2444.327809852287;9452.621895124186;9673.661421850202;9961.750956226153;10098.141657959082;10164.390136591828;1899.3921944977612;1962.6074785042906;1982.7323311352927;2004.288477590449;2177.444751588335;76475.32336368201;78982;84434.57782711109;87206.5639671804;87982;10401.68794936153;10440.738981525523;10826.729331766768;11096.667099987013;11382.487788049557;15640.139792311533;15693.372265109496;15752.369905203663;15791.526254212393;15791.842081579267;7735;8004.159563245776;8170.673173073011;8178.263956243966;8244.752657420288;7515.549067055994;7615.276548727862;7868.331191848757;7902.288794008452;7964.362850971908;4786.545278198635;4802.423709154924;4817.662763606584;4830;4892.363992680928;1899.3447260695038;1956.1490751523133;1956.3935180094215;2004.2884775904636;2011.3664195778576;898.6270697660528;909.1317791509225;918.9081091890757;983.3559018842669;991.2615101749243;20079.29722459736;20532.897335513226;20693.27573534919;20790.272340468313;20816.687749683766;958.8130314588589;993.4436715439377;1023.923205759571;1040.6149724601946;1041.037040737315;10932.672019839418;11241.437928103562;11282.661520154408;11320.830187547193;11401.600943966921;375894;376524;377358;468936;483320;79421.60289198517;96679.51660241795;103945;107507.46246268875;110083;1013.2501948558162;1016.3546148195949;1049.8162821506205;1053.204830353094;1061.0238580505952;17768.911155444657;18627.441176764718;18669.346572869883;18687.345942891934;18750.343737969106;42975;43683;44076;44144.33783493315;45377.319340209266;60510;61183.388166117766;61273.38726612677;61614.44976028723;62632.37367626448;8179.550124743197;8200.630971606412;8382.706605268786;8405.453645513022;8805.339599530189;12885.226886386472;13319.200847949154;13499.122557033761;13536.59390218295;13893.166410015432;11371;11545.249558778989;11636.883631163919;11827.40862956866;11917.22538035025;11084.334939903632;11174.161937854531;11256.493457794582;11277.32336059839;11398.430078495876;11593.24643898144;11609.5356185755;11689.766204676029;11752.706182345168;12039.518419263131;8086.048592263899;8240.711575094843;8425.115362886809;8442.071372148936;8617.82764344722;8562.315014798925;11378.08975281992;11405;11422.94288528552;11489 14:26:35 INFO - PROCESS | 28585 | |3;mootools.html;1477.4976507987283;1535.516312361606;1671.4150047483383;1790.5076104071386;1818.0909545227387;8504.702335418262;9195.908040919589;9296.302777291714;9300.441973481597;9311.208547273482;7426.740064097758;8489.78775530612;8695.39132260742;8709.477431354124;9028.187463128317;2288.4050146961786;2313.5025969416574;2314.895829687668;2316.51353215824;2316.9768302317016;2222.48882756966;2236.3626366485555;2279.4757205842666;2285.131649973008;2289.9885500572473;1987.9503012424661;2181.7163768710047;2234.430220293831;2247.022545192838;2270.5345404192185;2235.944101397462;2253.571821353946;2281.007761623699;2281.269993602048;2281.327008532487;2239.496113374494;2254.368776742515;2264.3546589222155;2265.6261716816707;2269.8184145268337;9081.318901082444;9110.134537218953;9177.816443671156;9178;9182.816343673156;5019.67372120811;5169.198774190007;5170.25031370453;5206.088934436459;5207.6354655174155;3093.71703783312;3232.0627018164705;3275.148461400029;3284.917877053069;3395.4227781276995;1126.7577470843808;1135.3585224348217;1151.642990672894;1154.261272785418;1154.786364522566;12518.311492867797;12528.185667931555;12544.498220071186;12551.435185416678;12552.748945021049;4316.848910288125;4389.209942210369;4505.909881802411;4555.589996900295;4564.748938808398;10600.734981625366;10600.840987385196;10612.575496980035;10615.84076238857;10624.043836054792;5158.4067832199025;5168.638195326366;5169.844904652867;5170.043541944752;5173.870653233624;4682.274247491644;4760.476347601761;4761.047790441926;4761.928571071437;4763.285507173882;3867.45855580219;3903.1608204236227;3914.2171565686976;3977.76133431995;4030.879073627796;1097.182598963777;1193.6061099837034;1206.10748046445;1210.2194084815244;1218.9268643881396;848.3764433141636;976.4873441443157;984.6750572311263;1011.4588695048261;1032.0041160280366;6251.718672659741;6271.090691849748;6280.905786413207;6380.457661098766;6418.390252925965;955.4171955107379;960.9135177833889;998.4608311511847;998.7852611688522;1034.7723500829804;4197.748135111842;4304.117655880537;4311.784410779448;4313.202057619351;4395.670324725658;11055.22613417053;11298.887011129784;11359.488823002985;11392.544298228144;11437.142214333791;10062.345947513388;11263.211575189822;11331.943340283411;11336.319820810777;11350.772984540428;7957.920420795834;8221.260086592236;8272;8520.147985201555;8522;6233.501319894307;6513.641749703622;6517.674116294261;6537.8692426152165;6580.341965803382;10256.589736410759;10358.326708763907;10372.22208334393;10391.220658450495;10407.375557466576;10028.899711002796;10362.067413932782;10371.481425928825;10723.142148628247;10754.677359679223;8027.317677997436;8152.551609661526;8159.714409995621;8162.387820913336;8170.387220958571;8691.608877600649;8771.210591046836;8854.203121719076;8887;8902.955485222532;7917.722879699183;7963.203679631991;8066.959665201636;8074.273315401642;8113.391495637969;7977.48146370484;7983.800404989922;8005.839883202187;8034;8082.030156381036;7318.158411782713;7322.048133742579;7368.742094026683;7378.262173782578;7379.188289288281;5187.144121219956;5236.397814251258;5309.150535914389;5367.543758780547;5372.811951581676;5366.865828354323;5380.381256155436;5430.13117901134;5535.944640553543;5682.659040457585 14:26:35 INFO - PROCESS | 28585 | |4;prototype.html;322.7127856207974;325.4776084384563;335.57382124701644;336.25519474364285;336.37602247830273;5316.5215130638235;5331.760070796809;5349.732513374325;5370.677759334442;5399.946000539993;5049.318342023826;5116.360454943132;5144.279800827878;5221.5822734181265;5307.920381194285;4125.2780763366445;4162.2924102902425;4170.47869016373;4195.937060944088;4199.2441360555085;4131.814068366915;4133.979330103345;4155.444401692967;4165.83336666533;4190.308599081148;3909.569947305794;4005.6581045349844;4116.135611521584;4117.661759928021;4126.917461650765;4101.22076805409;4104.733192342518;4110.97944510277;4111.773852438099;4136.524299705512;3655.4151335786146;3658.122050707811;3659.3779057560014;3666.120131168527;3670.5595328560476;5032.270320803463;5122.359705036871;5131.640785145041;5132.5124113209185;5175.378954525443;4707.7175369477945;4721.748736584807;4726.196546587088;4743.644226682978;4748.121597504472;5457.536109430703;5509.9255645149215;5519.503244707996;5522.061249587579;5530.5022547970875;3906.687465002793;4002.7198096133284;4003.8598649047435;4015.217032678629;4067.2882245607198;5636.943630563683;5664.178694089375;5669.433056694339;5684.971575142139;5705.62913410627;4098.713090083726;4116.91766164681;4149.6265336119895;4149.688773342012;4158.37624356349;3977.363621820553;4192.643625291885;4194.958050419517;4197.811098500575;4217.3463113216885;4743;4750.812296925768;4780.991983366995;4784.162771514971;4786.95213047872;5495.46127084417;5559.193916882029;5602.1036634139155;5609.4390560943575;5612.494875461228;1386.7226554689103;1425.615083927334;1450.8984371094134;1451.4194322270964;1451.5645306408035;923.9491827949392;931.8741969834122;939.389396892012;940.7977284883783;941.1670671455811;4773.570378665937;4782.808687652455;4786.664933454625;4806.735629540409;4825.782839772149;5069.847904562869;5082.263071854634;5083.694978301313;5090.389153301628;5105.064587861994;4373.497047839475;4772.95227047732;4782.187028205213;4783.727729328611;4785.994941062347;2672.9465410692064;2679.5846643770246;2682.5305571524905;2687.5699888018216;2693.612789413454;5197.376314842243;5249.317588713519;5249.895002099936;5264.973675131677;5275.973620131875;4836.879078023077;5100.719460429637;5109.850283686141;5163.302954101148;5192.8961420771375;5136.613114459075;5159.174532074925;5164.070467315844;5166.535011848801;5185.7407129644125;4989.625778066587;4991.801967527695;5001.724560237116;5021.87007923229;5063.670861393997;4815.422149342101;4922.138625740553;4971.657652433895;4998.325226094431;5004.924926126184;5147.716875571729;5152.6650767699975;5170.560502357192;5172.870678233075;5182.97408512955;3765.981170094132;3789.3368660484857;3790.753601015925;3951.5060617422823;3997.6801855852045;5546.584006199632;5589.944100558942;5603.327600687943;5603.579731520071;5662.66024038559;5438.293021907127;5455.236266922555;5456.61803673739;5463.72681365938;5514.834554963358;5331.253624492497;5479.726013699379;5506.91739623914;5509.944900551103;5514.862128446661;5383.9192412114635;5415.810446634507;5433.994710978482;5434;5449.23710680513;5477.972610136924;5497.618964336984;5507.972460137674;5512.5589952804485;5542.695151766691;5203.219517072469;5498.257735205696;5499.175123731312;5516.117421212587;5524 14:26:35 INFO - PROCESS | 28585 | |5;yui.html;768.5542385416459;784.0160598448946;800.7237503061442;826.8511667899777;883.2933653077538;15028.474003409883;15547.06717596945;15570.922145389271;15572.688546229068;15586.220688965548;14009.929950350259;14010.299485025733;14044.719105617882;14065.226412547307;14132.646683832909;675.8682056998887;798.5288679678988;809.7894547417684;818.2472125644422;823.3865770001357;805.9677612895506;813.5281536708725;815.7104227999034;816.1797393619433;817.3747083481142;865.9567021648924;872.0973792125152;872.31959071924;873.1312344217513;873.3668090634303;701.1691145991965;842.9283510901581;868.4224990381389;869.4652788535069;869.6695255802786;636.0205283862846;637.6875331087733;637.7289651897925;638.5402510192654;639.4628512049854;15796.368145274175;15945.441909533227;15948.20258987046;15963.44127955516;15968.281427335798;14839.406423743038;14856;14900.254987250702;15066;15197.620059498491;13553.59339219825;13560.049080733814;13606.31968401576;13778.793318100237;13995.86004139966;4543.241282680624;4564.6348292136545;4566.977165114186;4570.542945705436;4781.784819683123;78667;80618;80840;81015.5949220256;82380;11732.589359372552;11740.471678774476;11840.111991600492;11921.165518413802;12030.578929737418;22034.44913877134;22143.224987125373;22148.2248121315;22195.778042219372;22211.888940555193;8561.78595535104;8764.474131552128;8896.733098007071;8976.685815996409;8994.685186018458;4844.370231869905;4862.246351815475;4865.440474345425;4939.357883475197;5059.443461219263;3461.7749846259912;3531.170175008871;3568.3220188164164;3569.1434055826935;3574.91062723434;613.8588124731248;616.9074638804126;619.7490016543308;627.4948666323562;629.8425393651587;657.8036283063273;737.2516895351223;741.1809950005166;742.1168809117133;756.9053868266357;10175.898241017643;10225.539850706737;10308.690739277834;10333.379997200193;10361.585536578603;607.532200205839;620.7765204526366;702.7497183070712;703.1105651351045;715.2882881532908;4823.589994850477;5037.748112594356;5044.092063428545;5047.848564543069;5059.645824792303;71402.64298678473;92021.07978920259;112335;126880;127412;82840.58579707063;90162;106264.46867765611;109285;112079.43960280309;77695;79840.6007969968;83774.58112709397;85387;89361.10638893658;10225.642102526375;10295.176385889261;10484.108850747773;10597.145499537704;10622.20333475008;51275.743621283145;51302.486975131265;51588;52116.73941630268;53171;69548;78174;78659.21340786519;80585.19414805777;81816;12773.055525035545;13124.278164701032;13309.600711978655;13384.263865487103;13798.586042418743;15029.549113526611;15272.46546370916;15276.312565934337;15307.387704491695;15332.923335383251;13958.860411396163;14392.352344144329;14455.204963727096;14456.927715361357;14933;14407.711845763235;14909.403623854925;15027.323770430137;15596;15621.921890390475;13481.123726957716;13506.39221235027;14118.576442706735;14123.293835307988;14594.85405145935;11340.829887551528;11403.828942566033;11506.94246528762;11628.709282268012;11790.705232368917;11456.541738330374;11520.481578329163;12021.459034343301;12349.3825308736;12378.133530652767 14:26:35 INFO - PROCESS | 28585 | __end_tp_report 14:26:35 INFO - PROCESS | 28585 | __start_cc_report 14:26:35 INFO - PROCESS | 28585 | _x_x_mozilla_cycle_collect,1011 14:26:35 INFO - PROCESS | 28585 | __end_cc_report 14:26:35 INFO - PROCESS | 28585 | __startTimestamp1468963595675__endTimestamp 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | ------- Summary: start ------- 14:26:35 INFO - PROCESS | 28585 | Number of tests: 6 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | [#0] dojo.html Cycles:165 Average:5318.66 Median:5554.64 stddev:618.98 (11.1%) stddev-sans-first:594.03 14:26:35 INFO - PROCESS | 28585 | Values: 3020.1 3036.0 3058.7 3062.0 3073.2 5224.5 5283.5 5301.5 5362.0 5379.4 5373.0 5381.6 5395.4 5422.9 5436.9 4819.1 4870.9 4880.3 4886.8 5046.0 4956.0 4963.0 5006.3 5024.7 5029.3 4779.7 4790.4 4825.3 4844.9 4854.1 4811.4 4850.7 4921.1 4931.0 4976.1 4876.7 4877.3 4882.6 4885.1 4945.5 5194.2 5205.8 5211.5 5268.2 5288.0 5630.2 5638.1 5661.1 5665.4 5687.7 5554.6 5704.3 5710.7 5781.5 5791.4 5258.2 5278.2 5280.8 5339.9 5386.3 5901.2 5967.2 5974.5 5974.7 5975.0 5443.9 5628.5 5717.1 5727.3 5732.8 5717.0 5831.7 5837.2 5840.0 5840.9 5743.5 5784.8 5787.9 5833.4 5843.0 5526.9 5786.1 5797.2 5804.4 5810.4 4289.6 4309.2 4330.0 4349.2 4380.6 3883.4 3888.6 3897.5 3911.7 3918.7 5207.4 5341.5 5384.9 5385.6 5436.5 5680.1 5728.1 5750.8 5757.3 5802.5 5388.4 5391.7 5393.5 5394.0 5394.5 4695.3 4742.0 4756.1 4809.3 4843.8 5884.9 5916.9 5939.1 5939.8 5983.2 5707.1 5708.0 5716.5 5722.2 5727.7 5701.9 5854.7 5870.0 5888.8 5903.6 5654.5 5656.0 5658.0 5659.9 5660.9 5672.3 5750.3 5767.5 5775.1 5782.9 5442.6 5579.4 5621.2 5644.8 5685.2 5632.6 5658.4 5672.3 5672.4 5675.3 5406.8 5618.6 5636.2 5638.5 5644.7 5502.0 5604.8 5607.8 5613.0 5646.6 5475.5 5517.5 5575.8 5576.5 5579.6 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | [#1] ext.html Cycles:180 Average:59371.01 Median:24087.56 stddev:114447.41 (475.1%) stddev-sans-first:114683.43 14:26:35 INFO - PROCESS | 28585 | Values: 611.4 618.1 636.8 639.0 669.1 43653.3 45034.3 45260.3 48378.5 48652.0 45633.8 46426.3 46575.5 46580.5 46702.0 8939.7 9067.2 9078.4 9079.6 9080.6 8906.4 8972.7 8975.3 8982.1 8987.6 9006.3 9021.6 9038.0 9041.3 9042.1 9002.0 9011.3 9026.1 9026.1 9026.9 8870.6 8917.8 8919.5 8925.4 8935.3 43238.8 43255.0 43472.3 43511.3 43572.6 3758.5 3857.4 3862.4 3868.9 3960.9 33895.2 33974.3 34213.7 34750.0 35441.6 4400.3 4499.3 4526.2 4536.4 4546.7 336217.0 337318.0 338202.0 340891.0 342119.3 60869.4 60891.7 61159.0 61159.7 61274.0 54473.0 55349.0 55457.7 61117.7 63409.0 15291.3 15893.5 15968.4 16541.4 16554.0 12351.3 12406.4 12409.7 12429.2 12444.0 15974.2 18060.4 18174.4 18252.3 18274.5 5991.9 6040.1 6125.6 6131.2 6329.6 1024.5 1038.7 1049.5 1059.3 1110.0 34051.1 34360.5 34375.5 34417.1 34465.3 1069.5 1106.8 1121.8 1158.3 1255.5 17557.5 17591.6 17595.9 17598.4 17614.7 567274.0 569769.0 570335.3 572096.0 572137.0 58169.0 58693.4 58768.4 58775.4 58797.7 1311.8 1376.4 1381.5 1392.9 1395.3 31862.0 32545.7 32876.0 32959.7 33636.2 51527.5 51586.2 51907.7 51932.5 51946.2 343747.0 345170.0 345271.0 345379.0 345669.0 25126.0 28609.6 43469.6 46213.2 47174.3 48083.8 50137.7 50669.5 51540.2 52022.0 42484.0 43541.6 44023.3 44079.6 44483.6 43456.3 43514.6 43576.1 43774.8 44384.0 43433.3 44019.0 44128.3 44481.8 44523.6 37057.6 38174.4 38379.0 38981.8 39261.0 29579.4 29967.0 30023.4 30115.7 30338.5 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | [#2] jquery.html Cycles:180 Average:27319.25 Median:24721.57 stddev:69960.30 (283.0%) stddev-sans-first:70127.30 14:26:35 INFO - PROCESS | 28585 | Values: 376.5 389.0 400.4 406.3 413.7 14340.9 17395.5 19458.0 19649.2 19706.2 19511.9 20002.1 20222.6 20226.1 20250.4 5544.0 5570.7 5765.8 5803.4 5818.3 5583.3 5637.0 5688.2 5705.5 5707.2 5664.2 5673.3 5675.0 6160.0 6484.8 6424.1 6438.1 6462.8 6492.5 6493.5 5632.9 5822.7 5840.2 5843.2 5845.8 13368.2 13626.0 16318.6 24691.4 24751.8 2298.1 2304.1 2308.8 2363.4 2444.3 9452.6 9673.7 9961.8 10098.1 10164.4 1899.4 1962.6 1982.7 2004.3 2177.4 76475.3 78982.0 84434.6 87206.6 87982.0 10401.7 10440.7 10826.7 11096.7 11382.5 15640.1 15693.4 15752.4 15791.5 15791.8 7735.0 8004.2 8170.7 8178.3 8244.8 7515.5 7615.3 7868.3 7902.3 7964.4 4786.5 4802.4 4817.7 4830.0 4892.4 1899.3 1956.1 1956.4 2004.3 2011.4 898.6 909.1 918.9 983.4 991.3 20079.3 20532.9 20693.3 20790.3 20816.7 958.8 993.4 1023.9 1040.6 1041.0 10932.7 11241.4 11282.7 11320.8 11401.6 375894.0 376524.0 377358.0 468936.0 483320.0 79421.6 96679.5 103945.0 107507.5 110083.0 1013.3 1016.4 1049.8 1053.2 1061.0 17768.9 18627.4 18669.3 18687.3 18750.3 42975.0 43683.0 44076.0 44144.3 45377.3 60510.0 61183.4 61273.4 61614.4 62632.4 8179.6 8200.6 8382.7 8405.5 8805.3 12885.2 13319.2 13499.1 13536.6 13893.2 11371.0 11545.2 11636.9 11827.4 11917.2 11084.3 11174.2 11256.5 11277.3 11398.4 11593.2 11609.5 11689.8 11752.7 12039.5 8086.0 8240.7 8425.1 8442.1 8617.8 8562.3 11378.1 11405.0 11422.9 11489.0 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | [#3] mootools.html Cycles:180 Average:5932.17 Median:4530.75 stddev:3417.54 (75.4%) stddev-sans-first:3410.73 14:26:35 INFO - PROCESS | 28585 | Values: 1477.5 1535.5 1671.4 1790.5 1818.1 8504.7 9195.9 9296.3 9300.4 9311.2 7426.7 8489.8 8695.4 8709.5 9028.2 2288.4 2313.5 2314.9 2316.5 2317.0 2222.5 2236.4 2279.5 2285.1 2290.0 1988.0 2181.7 2234.4 2247.0 2270.5 2235.9 2253.6 2281.0 2281.3 2281.3 2239.5 2254.4 2264.4 2265.6 2269.8 9081.3 9110.1 9177.8 9178.0 9182.8 5019.7 5169.2 5170.3 5206.1 5207.6 3093.7 3232.1 3275.1 3284.9 3395.4 1126.8 1135.4 1151.6 1154.3 1154.8 12518.3 12528.2 12544.5 12551.4 12552.7 4316.8 4389.2 4505.9 4555.6 4564.7 10600.7 10600.8 10612.6 10615.8 10624.0 5158.4 5168.6 5169.8 5170.0 5173.9 4682.3 4760.5 4761.0 4761.9 4763.3 3867.5 3903.2 3914.2 3977.8 4030.9 1097.2 1193.6 1206.1 1210.2 1218.9 848.4 976.5 984.7 1011.5 1032.0 6251.7 6271.1 6280.9 6380.5 6418.4 955.4 960.9 998.5 998.8 1034.8 4197.7 4304.1 4311.8 4313.2 4395.7 11055.2 11298.9 11359.5 11392.5 11437.1 10062.3 11263.2 11331.9 11336.3 11350.8 7957.9 8221.3 8272.0 8520.1 8522.0 6233.5 6513.6 6517.7 6537.9 6580.3 10256.6 10358.3 10372.2 10391.2 10407.4 10028.9 10362.1 10371.5 10723.1 10754.7 8027.3 8152.6 8159.7 8162.4 8170.4 8691.6 8771.2 8854.2 8887.0 8903.0 7917.7 7963.2 8067.0 8074.3 8113.4 7977.5 7983.8 8005.8 8034.0 8082.0 7318.2 7322.0 7368.7 7378.3 7379.2 5187.1 5236.4 5309.2 5367.5 5372.8 5366.9 5380.4 5430.1 5535.9 5682.7 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | [#4] prototype.html Cycles:180 Average:4491.43 Median:5040.79 stddev:1282.50 (25.4%) stddev-sans-first:1247.35 14:26:35 INFO - PROCESS | 28585 | Values: 322.7 325.5 335.6 336.3 336.4 5316.5 5331.8 5349.7 5370.7 5399.9 5049.3 5116.4 5144.3 5221.6 5307.9 4125.3 4162.3 4170.5 4195.9 4199.2 4131.8 4134.0 4155.4 4165.8 4190.3 3909.6 4005.7 4116.1 4117.7 4126.9 4101.2 4104.7 4111.0 4111.8 4136.5 3655.4 3658.1 3659.4 3666.1 3670.6 5032.3 5122.4 5131.6 5132.5 5175.4 4707.7 4721.7 4726.2 4743.6 4748.1 5457.5 5509.9 5519.5 5522.1 5530.5 3906.7 4002.7 4003.9 4015.2 4067.3 5636.9 5664.2 5669.4 5685.0 5705.6 4098.7 4116.9 4149.6 4149.7 4158.4 3977.4 4192.6 4195.0 4197.8 4217.3 4743.0 4750.8 4781.0 4784.2 4787.0 5495.5 5559.2 5602.1 5609.4 5612.5 1386.7 1425.6 1450.9 1451.4 1451.6 923.9 931.9 939.4 940.8 941.2 4773.6 4782.8 4786.7 4806.7 4825.8 5069.8 5082.3 5083.7 5090.4 5105.1 4373.5 4773.0 4782.2 4783.7 4786.0 2672.9 2679.6 2682.5 2687.6 2693.6 5197.4 5249.3 5249.9 5265.0 5276.0 4836.9 5100.7 5109.9 5163.3 5192.9 5136.6 5159.2 5164.1 5166.5 5185.7 4989.6 4991.8 5001.7 5021.9 5063.7 4815.4 4922.1 4971.7 4998.3 5004.9 5147.7 5152.7 5170.6 5172.9 5183.0 3766.0 3789.3 3790.8 3951.5 3997.7 5546.6 5589.9 5603.3 5603.6 5662.7 5438.3 5455.2 5456.6 5463.7 5514.8 5331.3 5479.7 5506.9 5509.9 5514.9 5383.9 5415.8 5434.0 5434.0 5449.2 5478.0 5497.6 5508.0 5512.6 5542.7 5203.2 5498.3 5499.2 5516.1 5524.0 14:26:35 INFO - PROCESS | 28585 | 14:26:35 INFO - PROCESS | 28585 | [#5] yui.html Cycles:180 Average:21047.87 Median:4059.08 stddev:29689.98 (731.4%) stddev-sans-first:29734.22 14:26:35 INFO - PROCESS | 28585 | Values: 768.6 784.0 800.7 826.9 883.3 15028.5 15547.1 15570.9 15572.7 15586.2 14009.9 14010.3 14044.7 14065.2 14132.6 675.9 798.5 809.8 818.2 823.4 806.0 813.5 815.7 816.2 817.4 866.0 872.1 872.3 873.1 873.4 701.2 842.9 868.4 869.5 869.7 636.0 637.7 637.7 638.5 639.5 15796.4 15945.4 15948.2 15963.4 15968.3 14839.4 14856.0 14900.3 15066.0 15197.6 13553.6 13560.0 13606.3 13778.8 13995.9 4543.2 4564.6 4567.0 4570.5 4781.8 78667.0 80618.0 80840.0 81015.6 82380.0 11732.6 11740.5 11840.1 11921.2 12030.6 22034.4 22143.2 22148.2 22195.8 22211.9 8561.8 8764.5 8896.7 8976.7 8994.7 4844.4 4862.2 4865.4 4939.4 5059.4 3461.8 3531.2 3568.3 3569.1 3574.9 613.9 616.9 619.7 627.5 629.8 657.8 737.3 741.2 742.1 756.9 10175.9 10225.5 10308.7 10333.4 10361.6 607.5 620.8 702.7 703.1 715.3 4823.6 5037.7 5044.1 5047.8 5059.6 71402.6 92021.1 112335.0 126880.0 127412.0 82840.6 90162.0 106264.5 109285.0 112079.4 77695.0 79840.6 83774.6 85387.0 89361.1 10225.6 10295.2 10484.1 10597.1 10622.2 51275.7 51302.5 51588.0 52116.7 53171.0 69548.0 78174.0 78659.2 80585.2 81816.0 12773.1 13124.3 13309.6 13384.3 13798.6 15029.5 15272.5 15276.3 15307.4 15332.9 13958.9 14392.4 14455.2 14456.9 14933.0 14407.7 14909.4 15027.3 15596.0 15621.9 13481.1 13506.4 14118.6 14123.3 14594.9 11340.8 11403.8 11506.9 11628.7 11790.7 11456.5 11520.5 12021.5 12349.4 12378.1 14:26:35 INFO - PROCESS | 28585 | -------- Summary: end -------- 14:26:35 INFO - PROCESS | 28585 | 14:26:36 INFO - TEST-INFO | 28585: exit 0 14:26:36 INFO - TEST-OK | dromaeo_css | took 1113871ms 14:26:36 INFO - TEST-START | kraken 14:26:36 INFO - operating with platform_type : linux_ 14:26:36 INFO - Initialising browser for kraken test... 14:26:36 INFO - TEST-INFO | started process 28777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDyntb/profile http://localhost:33950/getInfo.html) 14:26:40 INFO - PROCESS | 28777 | __metrics Screen width/height:1600/1200 14:26:40 INFO - PROCESS | 28777 | colorDepth:24 14:26:40 INFO - PROCESS | 28777 | Browser inner width/height: 1024/697 14:26:40 INFO - PROCESS | 28777 | __metrics 14:26:41 INFO - PROCESS | 28777 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:26:41 INFO - PROCESS | 28777 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:26:42 INFO - TEST-INFO | 28777: exit 0 14:26:42 INFO - Browser initialized. 14:26:42 INFO - Running cycle 1/1 for kraken test... 14:26:42 INFO - TEST-INFO | started process 28859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDyntb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:54 INFO - PROCESS | 28859 | RSS: Main: 157913088 14:26:54 INFO - PROCESS | 28859 | 14:26:56 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33950/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:57 INFO - PROCESS | 28859 | RSS: Main: 217710592 14:26:57 INFO - PROCESS | 28859 | 14:27:00 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33950/tests/kraken/driver.html?testName=audio-dft) 14:27:00 INFO - PROCESS | 28859 | RSS: Main: 206299136 14:27:00 INFO - PROCESS | 28859 | 14:27:03 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33950/tests/kraken/driver.html?testName=audio-fft) 14:27:04 INFO - PROCESS | 28859 | RSS: Main: 269619200 14:27:04 INFO - PROCESS | 28859 | 14:27:06 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33950/tests/kraken/driver.html?testName=audio-oscillator) 14:27:06 INFO - PROCESS | 28859 | RSS: Main: 181407744 14:27:06 INFO - PROCESS | 28859 | 14:27:08 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33950/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:09 INFO - PROCESS | 28859 | RSS: Main: 184889344 14:27:09 INFO - PROCESS | 28859 | 14:27:12 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33950/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:13 INFO - PROCESS | 28859 | RSS: Main: 221020160 14:27:13 INFO - PROCESS | 28859 | 14:27:16 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33950/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:17 INFO - PROCESS | 28859 | RSS: Main: 221896704 14:27:17 INFO - PROCESS | 28859 | 14:27:19 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33950/tests/kraken/driver.html?testName=json-parse-financial) 14:27:20 INFO - PROCESS | 28859 | RSS: Main: 221986816 14:27:20 INFO - PROCESS | 28859 | 14:27:22 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33950/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:22 INFO - PROCESS | 28859 | RSS: Main: 210489344 14:27:22 INFO - PROCESS | 28859 | 14:27:24 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:24 INFO - PROCESS | 28859 | RSS: Main: 214224896 14:27:24 INFO - PROCESS | 28859 | 14:27:26 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:27 INFO - PROCESS | 28859 | RSS: Main: 211677184 14:27:27 INFO - PROCESS | 28859 | 14:27:30 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:30 INFO - PROCESS | 28859 | RSS: Main: 223444992 14:27:30 INFO - PROCESS | 28859 | 14:27:33 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:34 INFO - PROCESS | 28859 | RSS: Main: 225042432 14:27:34 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | Cycle 1(1): loaded http://localhost:33950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33950/tests/kraken/driver.html?testName=ai-astar) 14:27:35 INFO - PROCESS | 28859 | RSS: Main: 267804672 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | __start_tp_report 14:27:35 INFO - PROCESS | 28859 | _x_x_mozilla_page_load 14:27:35 INFO - PROCESS | 28859 | _x_x_mozilla_page_load_details 14:27:35 INFO - PROCESS | 28859 | |i|pagename|runs| 14:27:35 INFO - PROCESS | 28859 | |0;ai-astar;102;113;111;111;111;112;111;110;111;110 14:27:35 INFO - PROCESS | 28859 | |1;audio-beat-detection;149;116;116;172;118;118;147;115;150;115 14:27:35 INFO - PROCESS | 28859 | |2;audio-dft;161;162;161;159;160;160;162;161;162;163 14:27:35 INFO - PROCESS | 28859 | |3;audio-fft;75;73;75;129;75;76;74;73;102;73 14:27:35 INFO - PROCESS | 28859 | |4;audio-oscillator;83;82;115;84;84;84;120;83;84;132 14:27:35 INFO - PROCESS | 28859 | |5;imaging-gaussian-blur;117;119;118;117;116;116;118;116;116;117 14:27:35 INFO - PROCESS | 28859 | |6;imaging-darkroom;145;146;146;146;146;145;146;146;146;146 14:27:35 INFO - PROCESS | 28859 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 14:27:35 INFO - PROCESS | 28859 | |8;json-parse-financial;51;51;52;51;50;56;50;52;51;51 14:27:35 INFO - PROCESS | 28859 | |9;json-stringify-tinderbox;60;61;61;60;61;60;60;62;61;61 14:27:35 INFO - PROCESS | 28859 | |10;stanford-crypto-aes;77;76;75;74;75;75;75;75;74;78 14:27:35 INFO - PROCESS | 28859 | |11;stanford-crypto-ccm;128;128;136;126;116;127;117;119;167;132 14:27:35 INFO - PROCESS | 28859 | |12;stanford-crypto-pbkdf2;157;170;159;156;157;154;155;156;160;160 14:27:35 INFO - PROCESS | 28859 | |13;stanford-crypto-sha256-iterative;64;62;63;63;62;64;64;63;61;68 14:27:35 INFO - PROCESS | 28859 | __end_tp_report 14:27:35 INFO - PROCESS | 28859 | __start_cc_report 14:27:35 INFO - PROCESS | 28859 | _x_x_mozilla_cycle_collect,1644 14:27:35 INFO - PROCESS | 28859 | __end_cc_report 14:27:35 INFO - PROCESS | 28859 | __startTimestamp1468963655915__endTimestamp 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | ------- Summary: start ------- 14:27:35 INFO - PROCESS | 28859 | Number of tests: 14 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.01 (2.7%) stddev-sans-first:0.93 14:27:35 INFO - PROCESS | 28859 | Values: 102.0 113.0 111.0 111.0 111.0 112.0 111.0 110.0 111.0 110.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:132.50 stddev:20.87 (15.7%) stddev-sans-first:21.16 14:27:35 INFO - PROCESS | 28859 | Values: 149.0 116.0 116.0 172.0 118.0 118.0 147.0 115.0 150.0 115.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.27 14:27:35 INFO - PROCESS | 28859 | Values: 161.0 162.0 161.0 159.0 160.0 160.0 162.0 161.0 162.0 163.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.50 stddev:18.55 (24.9%) stddev-sans-first:19.47 14:27:35 INFO - PROCESS | 28859 | Values: 75.0 73.0 75.0 129.0 75.0 76.0 74.0 73.0 102.0 73.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.50 stddev:19.25 (23.1%) stddev-sans-first:19.91 14:27:35 INFO - PROCESS | 28859 | Values: 83.0 82.0 115.0 84.0 84.0 84.0 120.0 83.0 84.0 132.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 14:27:35 INFO - PROCESS | 28859 | Values: 117.0 119.0 118.0 117.0 116.0 116.0 118.0 116.0 116.0 117.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 14:27:35 INFO - PROCESS | 28859 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:27:35 INFO - PROCESS | 28859 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:1.72 (3.4%) stddev-sans-first:1.81 14:27:35 INFO - PROCESS | 28859 | Values: 51.0 51.0 52.0 51.0 50.0 56.0 50.0 52.0 51.0 51.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 14:27:35 INFO - PROCESS | 28859 | Values: 60.0 61.0 61.0 60.0 61.0 60.0 60.0 62.0 61.0 61.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:1.26 (1.7%) stddev-sans-first:1.20 14:27:35 INFO - PROCESS | 28859 | Values: 77.0 76.0 75.0 74.0 75.0 75.0 75.0 75.0 74.0 78.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:128.00 stddev:14.63 (11.4%) stddev-sans-first:15.51 14:27:35 INFO - PROCESS | 28859 | Values: 128.0 128.0 136.0 126.0 116.0 127.0 117.0 119.0 167.0 132.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.00 stddev:4.55 (2.9%) stddev-sans-first:4.80 14:27:35 INFO - PROCESS | 28859 | Values: 157.0 170.0 159.0 156.0 157.0 154.0 155.0 156.0 160.0 160.0 14:27:35 INFO - PROCESS | 28859 | 14:27:35 INFO - PROCESS | 28859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.90 (3.0%) stddev-sans-first:2.00 14:27:35 INFO - PROCESS | 28859 | Values: 64.0 62.0 63.0 63.0 62.0 64.0 64.0 63.0 61.0 68.0 14:27:35 INFO - PROCESS | 28859 | -------- Summary: end -------- 14:27:35 INFO - PROCESS | 28859 | 14:27:36 INFO - TEST-INFO | 28859: exit 0 14:27:36 INFO - TEST-OK | kraken | took 60503ms 14:27:36 INFO - SUITE-END | took 1174s 14:27:37 INFO - Completed test suite (00:19:34) 14:27:37 INFO - javascript benchmark 14:27:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.1392603108116, 3036.0284708893164, 3058.72471477567, 3062.020153550864, 3073.231692076981, 5224.5297923187, 5283.524482796547, 5301.496357846008, 5362.0, 5379.354477462705, 5373.032854086273, 5381.596380271476, 5395.406505284425, 5422.915416916613, 5436.885438485111, 4819.1325561398935, 4870.853874383774, 4880.316755654211, 4886.828960986366, 5046.041252162077, 4956.0, 4963.0, 5006.2740902569285, 5024.673396229234, 5029.270755740416, 4779.689320194177, 4790.425148982127, 4825.324454576362, 4844.927326090094, 4854.101991131652, 4811.422629284508, 4850.708957462528, 4921.114199444099, 4930.950690493085, 4976.104301225778, 4876.658633895629, 4877.268409738532, 4882.633802464794, 4885.071836351118, 4945.455999840015, 5194.194899790538, 5205.791768329263, 5211.478852114796, 5268.1834315681135, 5288.0, 5630.239917611111, 5638.126090455986, 5661.122526008476, 5665.3768085510565, 5687.7156142192725, 5554.638948468337, 5704.286964129484, 5710.657360558338, 5781.4507621775865, 5791.391903850077, 5258.237555554423, 5278.2346559749, 5280.841574752763, 5339.919901201485, 5386.299781028441, 5901.232839730894, 5967.16459695643, 5974.462298393166, 5974.701264936736, 5974.954382982961, 5443.945560544423, 5628.493435590816, 5717.056685646821, 5727.312722473246, 5732.828015159468, 5717.0, 5831.737571809279, 5837.211976383134, 5840.036393995028, 5840.853978650568, 5743.483086522233, 5784.8264552062665, 5787.855303617359, 5833.387494313036, 5843.03589907669, 5526.917096243559, 5786.132080188006, 5797.188393624896, 5804.390538993429, 5810.360860305363, 4289.592488713567, 4309.224339618899, 4330.0, 4349.173657005159, 4380.6057454829215, 3883.359245724424, 3888.572257051722, 3897.512810898638, 3911.7457365271166, 3918.6669133123432, 5207.427183009866, 5341.465853414705, 5384.865378365572, 5385.5960802939935, 5436.537894278951, 5680.062789639664, 5728.083506639001, 5750.7987220447085, 5757.251557297524, 5802.47777700009, 5388.407275199725, 5391.676499410048, 5393.514583687408, 5394.0, 5394.541463975606, 4695.295705644181, 4742.0, 4756.072565849695, 4809.254565542346, 4843.782029808667, 5884.852453771474, 5916.881662366729, 5939.13882487037, 5939.821805345847, 5983.222181116514, 5707.1153971134545, 5708.029634961983, 5716.485516303553, 5722.227499287543, 5727.713614319351, 5701.914471282851, 5854.707264636666, 5870.0, 5888.823335299948, 5903.557233207441, 5654.46282603152, 5655.953648575027, 5658.009848276452, 5659.86802639482, 5660.943390566042, 5672.347680016685, 5750.281214848144, 5767.509761670305, 5775.133729940542, 5782.884342313046, 5442.619016668795, 5579.414161513145, 5621.2411324472305, 5644.8306550803545, 5685.20407142992, 5632.5775566831835, 5658.377578466283, 5672.290963629546, 5672.404397538364, 5675.262215911905, 5406.810761623325, 5618.634788738719, 5636.21093046982, 5638.4925356718095, 5644.745986430703, 5502.0, 5604.775808967595, 5607.831765047055, 5613.045782217115, 5646.604737668324, 5475.5072043516275, 5517.503424691797, 5575.832725018256, 5576.4702353278, 5579.553635709215], "value": 5275.701785666457, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.4008271893545, 618.1006635345572, 636.8057742388572, 639.0414378432351, 669.1301308299215, 43653.34519982199, 45034.32448513271, 45260.32109518356, 48378.516214837844, 48652.0, 45633.77183114088, 46426.303605445864, 46575.534244657545, 46580.534194658045, 46702.0, 8939.687110951101, 9067.229285510739, 9078.364514483988, 9079.636814527412, 9080.636774529012, 8906.421082629608, 8972.730818075435, 8975.326850486206, 8982.056884027148, 8987.550622468883, 9006.279497640206, 9021.594028268712, 9038.0, 9041.276697864188, 9042.050584688579, 9001.95499022504, 9011.279097672235, 9026.097390260988, 9026.097390260988, 9026.86459703105, 8870.645174193089, 8917.777055573597, 8919.464832110094, 8925.375223734341, 8935.32985026119, 43238.78380608108, 43255.0, 43472.347914781305, 43511.34732979008, 43572.564274357166, 3758.49260349852, 3857.3828187489867, 3862.4206369044587, 3868.941965870514, 3960.881173564798, 33895.15262118442, 33974.32051358959, 34213.65786342129, 34750.0, 35441.64558354435, 4400.339949007643, 4499.347594598765, 4526.23054080807, 4536.364908912755, 4546.704464209849, 336217.0, 337318.0, 338202.0, 340891.0, 342119.2894035539, 60869.39130608726, 60891.69554152201, 61159.0, 61159.71881968308, 61274.0, 54473.0, 55349.0, 55457.72271138699, 61117.69441152766, 63409.0, 15291.311890964933, 15893.523194304189, 15968.441104561516, 16541.421050263183, 16554.0, 12351.320677362832, 12406.441710123067, 12409.689757755948, 12429.192102513307, 12444.0, 15974.201289935456, 18060.374566288836, 18174.36389726353, 18252.269909203747, 18274.543136421697, 5991.850203744942, 6040.134314039018, 6125.601835880653, 6131.233595800525, 6329.556931014785, 1024.5440778853338, 1038.657243109787, 1049.5172220778527, 1059.2743970380313, 1110.0, 34051.14872128217, 34360.48459273113, 34375.484367734505, 34417.13957151091, 34465.310693785985, 1069.4813015687384, 1106.80630889594, 1121.7980763462492, 1158.25871442277, 1255.453877563263, 17557.473275801745, 17591.648167036845, 17595.91202044007, 17598.38405655796, 17614.735778963324, 567274.0, 569769.0, 570335.33490993, 572096.0, 572137.0, 58169.0, 58693.41306586879, 58768.41231587715, 58775.41224587785, 58797.70601146967, 1311.8229039079793, 1376.4287820554357, 1381.4957540497646, 1392.9094608850594, 1395.330241484073, 31862.0, 32545.674543255212, 32876.0, 32959.67040329662, 33636.1590960228, 51527.484725152266, 51586.22620660768, 51907.74046129745, 51932.48067519276, 51946.220806687175, 343747.0, 345170.0, 345271.0, 345379.0, 345669.0, 25126.0, 28609.570856437585, 43469.56530434655, 46213.22334708161, 47174.29238561493, 48083.75958120327, 50137.74931125321, 50669.493305067954, 51540.226896597334, 52022.0, 42484.0, 43541.564584355016, 44023.339649904636, 44079.559204407546, 44483.55516444794, 43456.34815477834, 43514.56485435232, 43576.12847743091, 43774.78112609417, 44384.0, 43433.3484997719, 44019.0, 44128.33807492955, 44481.77759111184, 44523.55476445194, 37057.62942370542, 38174.427383588714, 38379.0, 38981.80509097436, 39261.0, 29579.40841183207, 29967.0, 30023.399532009673, 30115.698843012167, 30338.54492182575], "value": 20599.038569727898, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.5105363028066, 388.95915928827475, 400.4193918817715, 406.29507803960126, 413.7286298222758, 14340.928295358523, 17395.478135655936, 19458.0, 19649.21403143876, 19706.21175152994, 19511.902440487815, 20002.099905504252, 20222.595548089066, 20226.08982595783, 20250.39248822534, 5543.972280138593, 5570.721463926808, 5765.827025189251, 5803.390643982384, 5818.272715910512, 5583.302087239095, 5637.0, 5688.203651488795, 5705.48650621444, 5707.229524014268, 5664.235328230698, 5673.290838645169, 5675.0, 6159.969200154015, 6484.837879053014, 6424.132742079806, 6438.130852334945, 6462.773802916922, 6492.545521813498, 6493.480521558287, 5632.887342253132, 5822.679752613604, 5840.211571437844, 5843.152742852305, 5845.824625261249, 13368.197908125543, 13626.0, 16318.592035199097, 24691.38271543208, 24751.752482475124, 2298.0577963035075, 2304.1129165271323, 2308.803751681109, 2363.3973336799177, 2444.327809852287, 9452.621895124186, 9673.661421850202, 9961.750956226153, 10098.141657959082, 10164.390136591828, 1899.3921944977612, 1962.6074785042906, 1982.7323311352927, 2004.288477590449, 2177.444751588335, 76475.32336368201, 78982.0, 84434.57782711109, 87206.5639671804, 87982.0, 10401.68794936153, 10440.738981525523, 10826.729331766768, 11096.667099987013, 11382.487788049557, 15640.139792311533, 15693.372265109496, 15752.369905203663, 15791.526254212393, 15791.842081579267, 7735.0, 8004.159563245776, 8170.673173073011, 8178.263956243966, 8244.752657420288, 7515.549067055994, 7615.276548727862, 7868.331191848757, 7902.288794008452, 7964.362850971908, 4786.545278198635, 4802.423709154924, 4817.662763606584, 4830.0, 4892.363992680928, 1899.3447260695038, 1956.1490751523133, 1956.3935180094215, 2004.2884775904636, 2011.3664195778576, 898.6270697660528, 909.1317791509225, 918.9081091890757, 983.3559018842669, 991.2615101749243, 20079.29722459736, 20532.897335513226, 20693.27573534919, 20790.272340468313, 20816.687749683766, 958.8130314588589, 993.4436715439377, 1023.923205759571, 1040.6149724601946, 1041.037040737315, 10932.672019839418, 11241.437928103562, 11282.661520154408, 11320.830187547193, 11401.600943966921, 375894.0, 376524.0, 377358.0, 468936.0, 483320.0, 79421.60289198517, 96679.51660241795, 103945.0, 107507.46246268875, 110083.0, 1013.2501948558162, 1016.3546148195949, 1049.8162821506205, 1053.204830353094, 1061.0238580505952, 17768.911155444657, 18627.441176764718, 18669.346572869883, 18687.345942891934, 18750.343737969106, 42975.0, 43683.0, 44076.0, 44144.33783493315, 45377.319340209266, 60510.0, 61183.388166117766, 61273.38726612677, 61614.44976028723, 62632.37367626448, 8179.550124743197, 8200.630971606412, 8382.706605268786, 8405.453645513022, 8805.339599530189, 12885.226886386472, 13319.200847949154, 13499.122557033761, 13536.59390218295, 13893.166410015432, 11371.0, 11545.249558778989, 11636.883631163919, 11827.40862956866, 11917.22538035025, 11084.334939903632, 11174.161937854531, 11256.493457794582, 11277.32336059839, 11398.430078495876, 11593.24643898144, 11609.5356185755, 11689.766204676029, 11752.706182345168, 12039.518419263131, 8086.048592263899, 8240.711575094843, 8425.115362886809, 8442.071372148936, 8617.82764344722, 8562.315014798925, 11378.08975281992, 11405.0, 11422.94288528552, 11489.0], "value": 9231.323943013518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.4976507987283, 1535.516312361606, 1671.4150047483383, 1790.5076104071386, 1818.0909545227387, 8504.702335418262, 9195.908040919589, 9296.302777291714, 9300.441973481597, 9311.208547273482, 7426.740064097758, 8489.78775530612, 8695.39132260742, 8709.477431354124, 9028.187463128317, 2288.4050146961786, 2313.5025969416574, 2314.895829687668, 2316.51353215824, 2316.9768302317016, 2222.48882756966, 2236.3626366485555, 2279.4757205842666, 2285.131649973008, 2289.9885500572473, 1987.9503012424661, 2181.7163768710047, 2234.430220293831, 2247.022545192838, 2270.5345404192185, 2235.944101397462, 2253.571821353946, 2281.007761623699, 2281.269993602048, 2281.327008532487, 2239.496113374494, 2254.368776742515, 2264.3546589222155, 2265.6261716816707, 2269.8184145268337, 9081.318901082444, 9110.134537218953, 9177.816443671156, 9178.0, 9182.816343673156, 5019.67372120811, 5169.198774190007, 5170.25031370453, 5206.088934436459, 5207.6354655174155, 3093.71703783312, 3232.0627018164705, 3275.148461400029, 3284.917877053069, 3395.4227781276995, 1126.7577470843808, 1135.3585224348217, 1151.642990672894, 1154.261272785418, 1154.786364522566, 12518.311492867797, 12528.185667931555, 12544.498220071186, 12551.435185416678, 12552.748945021049, 4316.848910288125, 4389.209942210369, 4505.909881802411, 4555.589996900295, 4564.748938808398, 10600.734981625366, 10600.840987385196, 10612.575496980035, 10615.84076238857, 10624.043836054792, 5158.4067832199025, 5168.638195326366, 5169.844904652867, 5170.043541944752, 5173.870653233624, 4682.274247491644, 4760.476347601761, 4761.047790441926, 4761.928571071437, 4763.285507173882, 3867.45855580219, 3903.1608204236227, 3914.2171565686976, 3977.76133431995, 4030.879073627796, 1097.182598963777, 1193.6061099837034, 1206.10748046445, 1210.2194084815244, 1218.9268643881396, 848.3764433141636, 976.4873441443157, 984.6750572311263, 1011.4588695048261, 1032.0041160280366, 6251.718672659741, 6271.090691849748, 6280.905786413207, 6380.457661098766, 6418.390252925965, 955.4171955107379, 960.9135177833889, 998.4608311511847, 998.7852611688522, 1034.7723500829804, 4197.748135111842, 4304.117655880537, 4311.784410779448, 4313.202057619351, 4395.670324725658, 11055.22613417053, 11298.887011129784, 11359.488823002985, 11392.544298228144, 11437.142214333791, 10062.345947513388, 11263.211575189822, 11331.943340283411, 11336.319820810777, 11350.772984540428, 7957.920420795834, 8221.260086592236, 8272.0, 8520.147985201555, 8522.0, 6233.501319894307, 6513.641749703622, 6517.674116294261, 6537.8692426152165, 6580.341965803382, 10256.589736410759, 10358.326708763907, 10372.22208334393, 10391.220658450495, 10407.375557466576, 10028.899711002796, 10362.067413932782, 10371.481425928825, 10723.142148628247, 10754.677359679223, 8027.317677997436, 8152.551609661526, 8159.714409995621, 8162.387820913336, 8170.387220958571, 8691.608877600649, 8771.210591046836, 8854.203121719076, 8887.0, 8902.955485222532, 7917.722879699183, 7963.203679631991, 8066.959665201636, 8074.273315401642, 8113.391495637969, 7977.48146370484, 7983.800404989922, 8005.839883202187, 8034.0, 8082.030156381036, 7318.158411782713, 7322.048133742579, 7368.742094026683, 7378.262173782578, 7379.188289288281, 5187.144121219956, 5236.397814251258, 5309.150535914389, 5367.543758780547, 5372.811951581676, 5366.865828354323, 5380.381256155436, 5430.13117901134, 5535.944640553543, 5682.659040457585], "value": 4709.201935942956, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.7127856207974, 325.4776084384563, 335.57382124701644, 336.25519474364285, 336.37602247830273, 5316.5215130638235, 5331.760070796809, 5349.732513374325, 5370.677759334442, 5399.946000539993, 5049.318342023826, 5116.360454943132, 5144.279800827878, 5221.5822734181265, 5307.920381194285, 4125.2780763366445, 4162.2924102902425, 4170.47869016373, 4195.937060944088, 4199.2441360555085, 4131.814068366915, 4133.979330103345, 4155.444401692967, 4165.83336666533, 4190.308599081148, 3909.569947305794, 4005.6581045349844, 4116.135611521584, 4117.661759928021, 4126.917461650765, 4101.22076805409, 4104.733192342518, 4110.97944510277, 4111.773852438099, 4136.524299705512, 3655.4151335786146, 3658.122050707811, 3659.3779057560014, 3666.120131168527, 3670.5595328560476, 5032.270320803463, 5122.359705036871, 5131.640785145041, 5132.5124113209185, 5175.378954525443, 4707.7175369477945, 4721.748736584807, 4726.196546587088, 4743.644226682978, 4748.121597504472, 5457.536109430703, 5509.9255645149215, 5519.503244707996, 5522.061249587579, 5530.5022547970875, 3906.687465002793, 4002.7198096133284, 4003.8598649047435, 4015.217032678629, 4067.2882245607198, 5636.943630563683, 5664.178694089375, 5669.433056694339, 5684.971575142139, 5705.62913410627, 4098.713090083726, 4116.91766164681, 4149.6265336119895, 4149.688773342012, 4158.37624356349, 3977.363621820553, 4192.643625291885, 4194.958050419517, 4197.811098500575, 4217.3463113216885, 4743.0, 4750.812296925768, 4780.991983366995, 4784.162771514971, 4786.95213047872, 5495.46127084417, 5559.193916882029, 5602.1036634139155, 5609.4390560943575, 5612.494875461228, 1386.7226554689103, 1425.615083927334, 1450.8984371094134, 1451.4194322270964, 1451.5645306408035, 923.9491827949392, 931.8741969834122, 939.389396892012, 940.7977284883783, 941.1670671455811, 4773.570378665937, 4782.808687652455, 4786.664933454625, 4806.735629540409, 4825.782839772149, 5069.847904562869, 5082.263071854634, 5083.694978301313, 5090.389153301628, 5105.064587861994, 4373.497047839475, 4772.95227047732, 4782.187028205213, 4783.727729328611, 4785.994941062347, 2672.9465410692064, 2679.5846643770246, 2682.5305571524905, 2687.5699888018216, 2693.612789413454, 5197.376314842243, 5249.317588713519, 5249.895002099936, 5264.973675131677, 5275.973620131875, 4836.879078023077, 5100.719460429637, 5109.850283686141, 5163.302954101148, 5192.8961420771375, 5136.613114459075, 5159.174532074925, 5164.070467315844, 5166.535011848801, 5185.7407129644125, 4989.625778066587, 4991.801967527695, 5001.724560237116, 5021.87007923229, 5063.670861393997, 4815.422149342101, 4922.138625740553, 4971.657652433895, 4998.325226094431, 5004.924926126184, 5147.716875571729, 5152.6650767699975, 5170.560502357192, 5172.870678233075, 5182.97408512955, 3765.981170094132, 3789.3368660484857, 3790.753601015925, 3951.5060617422823, 3997.6801855852045, 5546.584006199632, 5589.944100558942, 5603.327600687943, 5603.579731520071, 5662.66024038559, 5438.293021907127, 5455.236266922555, 5456.61803673739, 5463.72681365938, 5514.834554963358, 5331.253624492497, 5479.726013699379, 5506.91739623914, 5509.944900551103, 5514.862128446661, 5383.9192412114635, 5415.810446634507, 5433.994710978482, 5434.0, 5449.23710680513, 5477.972610136924, 5497.618964336984, 5507.972460137674, 5512.5589952804485, 5542.695151766691, 5203.219517072469, 5498.257735205696, 5499.175123731312, 5516.117421212587, 5524.0], "value": 4087.2996391772554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.5542385416459, 784.0160598448946, 800.7237503061442, 826.8511667899777, 883.2933653077538, 15028.474003409883, 15547.06717596945, 15570.922145389271, 15572.688546229068, 15586.220688965548, 14009.929950350259, 14010.299485025733, 14044.719105617882, 14065.226412547307, 14132.646683832909, 675.8682056998887, 798.5288679678988, 809.7894547417684, 818.2472125644422, 823.3865770001357, 805.9677612895506, 813.5281536708725, 815.7104227999034, 816.1797393619433, 817.3747083481142, 865.9567021648924, 872.0973792125152, 872.31959071924, 873.1312344217513, 873.3668090634303, 701.1691145991965, 842.9283510901581, 868.4224990381389, 869.4652788535069, 869.6695255802786, 636.0205283862846, 637.6875331087733, 637.7289651897925, 638.5402510192654, 639.4628512049854, 15796.368145274175, 15945.441909533227, 15948.20258987046, 15963.44127955516, 15968.281427335798, 14839.406423743038, 14856.0, 14900.254987250702, 15066.0, 15197.620059498491, 13553.59339219825, 13560.049080733814, 13606.31968401576, 13778.793318100237, 13995.86004139966, 4543.241282680624, 4564.6348292136545, 4566.977165114186, 4570.542945705436, 4781.784819683123, 78667.0, 80618.0, 80840.0, 81015.5949220256, 82380.0, 11732.589359372552, 11740.471678774476, 11840.111991600492, 11921.165518413802, 12030.578929737418, 22034.44913877134, 22143.224987125373, 22148.2248121315, 22195.778042219372, 22211.888940555193, 8561.78595535104, 8764.474131552128, 8896.733098007071, 8976.685815996409, 8994.685186018458, 4844.370231869905, 4862.246351815475, 4865.440474345425, 4939.357883475197, 5059.443461219263, 3461.7749846259912, 3531.170175008871, 3568.3220188164164, 3569.1434055826935, 3574.91062723434, 613.8588124731248, 616.9074638804126, 619.7490016543308, 627.4948666323562, 629.8425393651587, 657.8036283063273, 737.2516895351223, 741.1809950005166, 742.1168809117133, 756.9053868266357, 10175.898241017643, 10225.539850706737, 10308.690739277834, 10333.379997200193, 10361.585536578603, 607.532200205839, 620.7765204526366, 702.7497183070712, 703.1105651351045, 715.2882881532908, 4823.589994850477, 5037.748112594356, 5044.092063428545, 5047.848564543069, 5059.645824792303, 71402.64298678473, 92021.07978920259, 112335.0, 126880.0, 127412.0, 82840.58579707063, 90162.0, 106264.46867765611, 109285.0, 112079.43960280309, 77695.0, 79840.6007969968, 83774.58112709397, 85387.0, 89361.10638893658, 10225.642102526375, 10295.176385889261, 10484.108850747773, 10597.145499537704, 10622.20333475008, 51275.743621283145, 51302.486975131265, 51588.0, 52116.73941630268, 53171.0, 69548.0, 78174.0, 78659.21340786519, 80585.19414805777, 81816.0, 12773.055525035545, 13124.278164701032, 13309.600711978655, 13384.263865487103, 13798.586042418743, 15029.549113526611, 15272.46546370916, 15276.312565934337, 15307.387704491695, 15332.923335383251, 13958.860411396163, 14392.352344144329, 14455.204963727096, 14456.927715361357, 14933.0, 14407.711845763235, 14909.403623854925, 15027.323770430137, 15596.0, 15621.921890390475, 13481.123726957716, 13506.39221235027, 14118.576442706735, 14123.293835307988, 14594.85405145935, 11340.829887551528, 11403.828942566033, 11506.94246528762, 11628.709282268012, 11790.705232368917, 11456.541738330374, 11520.481578329163, 12021.459034343301, 12349.3825308736, 12378.133530652767], "value": 7794.085106452099, "unit": "score"}], "name": "dromaeo_css", "value": 7293.420367526997, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 111.0, 111.0, 112.0, 111.0, 110.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 116.0, 172.0, 118.0, 118.0, 147.0, 115.0, 150.0, 115.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 159.0, 160.0, 160.0, 162.0, 161.0, 162.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 129.0, 75.0, 76.0, 74.0, 73.0, 102.0, 73.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 84.0, 84.0, 84.0, 120.0, 83.0, 84.0, 132.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 116.0, 116.0, 118.0, 116.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 50.0, 56.0, 50.0, 52.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 62.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 74.0, 75.0, 75.0, 75.0, 75.0, 74.0, 78.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 136.0, 126.0, 116.0, 127.0, 117.0, 119.0, 167.0, 132.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 170.0, 159.0, 156.0, 157.0, 154.0, 155.0, 156.0, 160.0, 160.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 62.0, 64.0, 64.0, 63.0, 61.0, 68.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1477.2, "alertThreshold": 2.0}]} 14:27:37 INFO - Return code: 0 14:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:27:37 INFO - # TBPL SUCCESS # 14:27:37 INFO - Running post-action listener: _resource_record_post_action 14:27:37 INFO - ##### 14:27:37 INFO - ##### Finished run-tests step (success) 14:27:37 INFO - ##### 14:27:37 INFO - Running post-run listener: _resource_record_post_run 14:27:37 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 45056; Write bytes: 308805632; Read time: 228; Write time: 214124 14:27:37 INFO - TinderboxPrint: CPU usage
13.1% 14:27:37 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 228 14:27:37 INFO - TinderboxPrint: I/O write bytes / time
308,805,632 / 214,124 14:27:37 INFO - TinderboxPrint: CPU idle
8,270.0 (86.9%) 14:27:37 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 14:27:37 INFO - TinderboxPrint: Swap in / out
0 / 0 14:27:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13910016; Read time: 0; Write time: 2032 14:27:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 40960; Write bytes: 294895616; Read time: 212; Write time: 212092 14:27:37 INFO - Running post-run listener: _upload_blobber_files 14:27:37 INFO - Blob upload gear active. 14:27:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:27:37 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 14:27:37 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'] 14:27:37 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 14:27:38 INFO - (blobuploader) - INFO - Open directory for files ... 14:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:38 INFO - (blobuploader) - INFO - Done attempting. 14:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:39 INFO - (blobuploader) - INFO - Done attempting. 14:27:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:27:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:27:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:44 INFO - (blobuploader) - INFO - Done attempting. 14:27:44 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:44 INFO - Return code: 0 14:27:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:27:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb8a6ce062d453163cc288a16e5efb9e94b01a36e9ba9cb4054f619b446107aa2a661d00c59d2b11836aa7bdf39f323b702530e6ceb64c52896b52a2954d5cfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf8a618ca2288411a41e9488ddc3ab6e5027939f300c6e321139a2dbd637bcf0ca22366e06ab1e911ae300ac8f686b0fa8e2b9320bde86d47a52da78f8061ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfd434b6639d253fda542539d3e0973cf92cc284be598c3ce51bc086ac66044850dfcfbd3b83242eb29ce21b6ea744a04a01fe1445d1e1a81572defec99302c4"} 14:27:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:27:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:27:44 INFO - Contents: 14:27:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb8a6ce062d453163cc288a16e5efb9e94b01a36e9ba9cb4054f619b446107aa2a661d00c59d2b11836aa7bdf39f323b702530e6ceb64c52896b52a2954d5cfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf8a618ca2288411a41e9488ddc3ab6e5027939f300c6e321139a2dbd637bcf0ca22366e06ab1e911ae300ac8f686b0fa8e2b9320bde86d47a52da78f8061ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfd434b6639d253fda542539d3e0973cf92cc284be598c3ce51bc086ac66044850dfcfbd3b83242eb29ce21b6ea744a04a01fe1445d1e1a81572defec99302c4"} 14:27:44 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:44 INFO - Copying logs to upload dir... 14:27:44 INFO - mkdir: /builds/slave/test/build/upload/logs 14:27:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.764333 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-19 14:27:44.222235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 14:27:44.225690) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb8a6ce062d453163cc288a16e5efb9e94b01a36e9ba9cb4054f619b446107aa2a661d00c59d2b11836aa7bdf39f323b702530e6ceb64c52896b52a2954d5cfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf8a618ca2288411a41e9488ddc3ab6e5027939f300c6e321139a2dbd637bcf0ca22366e06ab1e911ae300ac8f686b0fa8e2b9320bde86d47a52da78f8061ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfd434b6639d253fda542539d3e0973cf92cc284be598c3ce51bc086ac66044850dfcfbd3b83242eb29ce21b6ea744a04a01fe1445d1e1a81572defec99302c4"} build_url:https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/AEC0nk9ETwSyn5vFek983w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb8a6ce062d453163cc288a16e5efb9e94b01a36e9ba9cb4054f619b446107aa2a661d00c59d2b11836aa7bdf39f323b702530e6ceb64c52896b52a2954d5cfa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf8a618ca2288411a41e9488ddc3ab6e5027939f300c6e321139a2dbd637bcf0ca22366e06ab1e911ae300ac8f686b0fa8e2b9320bde86d47a52da78f8061ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfd434b6639d253fda542539d3e0973cf92cc284be598c3ce51bc086ac66044850dfcfbd3b83242eb29ce21b6ea744a04a01fe1445d1e1a81572defec99302c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 14:27:44.250881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:27:44.251262) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1468962395.921283-469288884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:27:44.337088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 14:27:44.337409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 14:27:44.337701) ========= ========= Total master_lag: 0.16 =========