builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1470744864.41 results: success (0) buildid: 20160809023001 builduid: 7ad9101e5ff64756950b2ecf6a3853b1 revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.411277) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.411764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.412058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.447241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.447722) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 05:14:24-- 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% 110M=0s 2016-08-09 05:14:24 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.571372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.571707) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021041 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.631994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:24.632415) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2edc35144ebf50ca6339e686e766e200cc4b04b8 --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 2edc35144ebf50ca6339e686e766e200cc4b04b8 --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=20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 05:14:24,901 truncating revision to first 12 chars 2016-08-09 05:14:24,901 Setting DEBUG logging. 2016-08-09 05:14:24,901 attempt 1/10 2016-08-09 05:14:24,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2edc35144ebf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 05:14:25,378 unpacking tar archive at: fx-team-2edc35144ebf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.807629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:25.453656) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:25.453991) ========= script_repo_revision: 2edc35144ebf50ca6339e686e766e200cc4b04b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:25.454506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:25.454786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:14:25.467727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-09 05:14:25.468002) ========= /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=20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:25 INFO - MultiFileLogger online at 20160809 05:14:25 in /builds/slave/test 05:14:25 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 05:14:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:25 INFO - {'append_to_log': False, 05:14:25 INFO - 'base_work_dir': '/builds/slave/test', 05:14:25 INFO - 'blob_upload_branch': 'Fx-Team', 05:14:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:25 INFO - 'branch': 'Fx-Team', 05:14:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:25 INFO - 'config_files': ('talos/linux_config.py',), 05:14:25 INFO - 'default_actions': ('clobber', 05:14:25 INFO - 'read-buildbot-config', 05:14:25 INFO - 'download-and-extract', 05:14:25 INFO - 'populate-webroot', 05:14:25 INFO - 'create-virtualenv', 05:14:25 INFO - 'install', 05:14:25 INFO - 'run-tests'), 05:14:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:25 INFO - 'download_minidump_stackwalk': True, 05:14:25 INFO - 'download_symbols': 'ondemand', 05:14:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:25 INFO - 'installer_path': 'installer.exe', 05:14:25 INFO - 'log_level': 'info', 05:14:25 INFO - 'log_name': 'talos', 05:14:25 INFO - 'log_to_console': True, 05:14:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:25 INFO - 'opt_config_files': (), 05:14:25 INFO - 'pip_index': False, 05:14:25 INFO - 'sps_profile': False, 05:14:25 INFO - 'sps_profile_interval': 0, 05:14:25 INFO - 'suite': 'dromaeojs', 05:14:25 INFO - 'system_bits': '32', 05:14:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:25 INFO - 'title': 'talos-linux64-ix-015', 05:14:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:25 INFO - 'use_talos_json': True, 05:14:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:25 INFO - 'work_dir': 'build'} 05:14:25 INFO - [mozharness: 2016-08-09 12:14:25.836916Z] Running clobber step. 05:14:25 INFO - Running pre-action listener: _resource_record_pre_action 05:14:25 INFO - Running main action method: clobber 05:14:25 INFO - rmtree: /builds/slave/test/build 05:14:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:26 INFO - Running post-action listener: _resource_record_post_action 05:14:26 INFO - [mozharness: 2016-08-09 12:14:26.297708Z] Finished clobber step (success) 05:14:26 INFO - [mozharness: 2016-08-09 12:14:26.297809Z] Running read-buildbot-config step. 05:14:26 INFO - Running pre-action listener: _resource_record_pre_action 05:14:26 INFO - Running main action method: read_buildbot_config 05:14:26 INFO - Using buildbot properties: 05:14:26 INFO - { 05:14:26 INFO - "project": "", 05:14:26 INFO - "product": "firefox", 05:14:26 INFO - "script_repo_revision": "production", 05:14:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:14:26 INFO - "repository": "", 05:14:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:14:26 INFO - "buildid": "20160809023001", 05:14:26 INFO - "pgo_build": "True", 05:14:26 INFO - "basedir": "/builds/slave/test", 05:14:26 INFO - "buildnumber": 346, 05:14:26 INFO - "slavename": "talos-linux64-ix-015", 05:14:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:14:26 INFO - "platform": "ubuntu64_hw", 05:14:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:14:26 INFO - "branch": "fx-team", 05:14:26 INFO - "repo_path": "integration/fx-team", 05:14:26 INFO - "revision": "2edc35144ebf50ca6339e686e766e200cc4b04b8", 05:14:26 INFO - "stage_platform": "linux64-pgo", 05:14:26 INFO - "builduid": "7ad9101e5ff64756950b2ecf6a3853b1", 05:14:26 INFO - "slavebuilddir": "test" 05:14:26 INFO - } 05:14:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:14:26 INFO - Running post-action listener: _resource_record_post_action 05:14:26 INFO - [mozharness: 2016-08-09 12:14:26.300322Z] Finished read-buildbot-config step (success) 05:14:26 INFO - [mozharness: 2016-08-09 12:14:26.300411Z] Running download-and-extract step. 05:14:26 INFO - Running pre-action listener: _resource_record_pre_action 05:14:26 INFO - Running main action method: download_and_extract 05:14:26 INFO - mkdir: /builds/slave/test/build/tests 05:14:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:26 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:14:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:14:26 INFO - Downloaded 1361 bytes. 05:14:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:14:26 INFO - Using the following test package requirements: 05:14:26 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:14:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'jsshell-linux-x86_64.zip'], 05:14:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:14:26 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:14:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:26 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:27 INFO - Downloaded 21828529 bytes. 05:14:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:28 INFO - Return code: 0 05:14:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:28 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:29 INFO - Downloaded 21828529 bytes. 05:14:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:31 INFO - Return code: 0 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:31 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:14:32 INFO - Downloaded 14413723 bytes. 05:14:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:14:32 INFO - Return code: 0 05:14:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:32 INFO - trying https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:14:33 INFO - Downloaded 59972166 bytes. 05:14:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:33 INFO - mkdir: /builds/slave/test/properties 05:14:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:33 INFO - Contents: 05:14:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:34 INFO - Running post-action listener: _resource_record_post_action 05:14:34 INFO - Running post-action listener: set_extra_try_arguments 05:14:34 INFO - [mozharness: 2016-08-09 12:14:34.679002Z] Finished download-and-extract step (success) 05:14:34 INFO - [mozharness: 2016-08-09 12:14:34.679322Z] Running populate-webroot step. 05:14:34 INFO - Running pre-action listener: _resource_record_pre_action 05:14:34 INFO - Running main action method: populate_webroot 05:14:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:34 INFO - '--tppagecycles', 05:14:34 INFO - '7'], 05:14:34 INFO - 'tests': ['tsvgm']}}, 05:14:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['damp', 'tps']}, 05:14:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'tests': ['damp', 'tps']}, 05:14:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['dromaeo_dom']}, 05:14:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['basic_compositor_video']}, 05:14:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:14:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['a11yr', 05:14:34 INFO - 'ts_paint', 05:14:34 INFO - 'tpaint', 05:14:34 INFO - 'sessionrestore', 05:14:34 INFO - 'sessionrestore_no_auto_restore', 05:14:34 INFO - 'tabpaint']}, 05:14:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:34 INFO - 'ts_paint', 05:14:34 INFO - 'tpaint', 05:14:34 INFO - 'sessionrestore', 05:14:34 INFO - 'sessionrestore_no_auto_restore', 05:14:34 INFO - 'tabpaint']}, 05:14:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:34 INFO - 'ts_paint', 05:14:34 INFO - 'tpaint', 05:14:34 INFO - 'sessionrestore', 05:14:34 INFO - 'sessionrestore_no_auto_restore', 05:14:34 INFO - 'tabpaint']}, 05:14:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:34 INFO - 'ts_paint', 05:14:34 INFO - 'tpaint', 05:14:34 INFO - 'sessionrestore', 05:14:34 INFO - 'sessionrestore_no_auto_restore', 05:14:34 INFO - 'tabpaint']}, 05:14:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['a11yr', 05:14:34 INFO - 'ts_paint', 05:14:34 INFO - 'tpaint', 05:14:34 INFO - 'sessionrestore', 05:14:34 INFO - 'sessionrestore_no_auto_restore', 05:14:34 INFO - 'tabpaint']}, 05:14:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['a11yr', 05:14:34 INFO - 'ts_paint', 05:14:34 INFO - 'tpaint', 05:14:34 INFO - 'sessionrestore', 05:14:34 INFO - 'sessionrestore_no_auto_restore', 05:14:34 INFO - 'tabpaint']}, 05:14:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['tsvgx', 05:14:34 INFO - 'tsvgr_opacity', 05:14:34 INFO - 'tart', 05:14:34 INFO - 'tscrollx', 05:14:34 INFO - 'cart']}, 05:14:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:34 INFO - 'tsvgr_opacity', 05:14:34 INFO - 'tart', 05:14:34 INFO - 'tscrollx', 05:14:34 INFO - 'cart']}, 05:14:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'talos_options': ['--disable-e10s'], 05:14:34 INFO - 'tests': ['tp5o']}, 05:14:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'tests': ['tp5o']}, 05:14:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'talos_options': ['--disable-e10s', 05:14:34 INFO - '--xperf_path', 05:14:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:34 INFO - 'tests': ['tp5n']}, 05:14:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:34 INFO - 'talos_options': ['--xperf_path', 05:14:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:34 INFO - 'tests': ['tp5n']}}, 05:14:34 INFO - 'talos.zip': {'path': '', 05:14:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:34 INFO - Running post-action listener: _resource_record_post_action 05:14:34 INFO - [mozharness: 2016-08-09 12:14:34.695168Z] Finished populate-webroot step (success) 05:14:34 INFO - [mozharness: 2016-08-09 12:14:34.695258Z] Running create-virtualenv step. 05:14:34 INFO - Running pre-action listener: _resource_record_pre_action 05:14:34 INFO - Running main action method: create_virtualenv 05:14:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:34 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 05:14:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:34 INFO - Using real prefix '/usr' 05:14:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:37 INFO - Installing pip.................done. 05:14:37 INFO - Return code: 0 05:14:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:14:37 INFO - Using env: {'DISPLAY': ':0', 05:14:37 INFO - 'HOME': '/home/cltbld', 05:14:37 INFO - 'LANG': 'en_US.UTF-8', 05:14:37 INFO - 'LANGUAGE': 'en_US:en', 05:14:37 INFO - 'LOGNAME': 'cltbld', 05:14:37 INFO - 'MAIL': '/var/mail/cltbld', 05:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:37 INFO - 'MOZ_NO_REMOTE': '1', 05:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:37 INFO - 'NO_EM_RESTART': '1', 05:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:37 INFO - 'PWD': '/builds/slave/test', 05:14:37 INFO - 'SHELL': '/bin/bash', 05:14:37 INFO - 'SHLVL': '1', 05:14:37 INFO - 'TERM': 'linux', 05:14:37 INFO - 'TMOUT': '86400', 05:14:37 INFO - 'USER': 'cltbld', 05:14:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:37 INFO - '_': '/tools/buildbot/bin/python'} 05:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:37 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 05:14:37 INFO - Cleaning up... 05:14:37 INFO - Return code: 0 05:14:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:14:37 INFO - Using env: {'DISPLAY': ':0', 05:14:37 INFO - 'HOME': '/home/cltbld', 05:14:37 INFO - 'LANG': 'en_US.UTF-8', 05:14:37 INFO - 'LANGUAGE': 'en_US:en', 05:14:37 INFO - 'LOGNAME': 'cltbld', 05:14:37 INFO - 'MAIL': '/var/mail/cltbld', 05:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:37 INFO - 'MOZ_NO_REMOTE': '1', 05:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:37 INFO - 'NO_EM_RESTART': '1', 05:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:37 INFO - 'PWD': '/builds/slave/test', 05:14:37 INFO - 'SHELL': '/bin/bash', 05:14:37 INFO - 'SHLVL': '1', 05:14:37 INFO - 'TERM': 'linux', 05:14:37 INFO - 'TMOUT': '86400', 05:14:37 INFO - 'USER': 'cltbld', 05:14:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:37 INFO - '_': '/tools/buildbot/bin/python'} 05:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:37 INFO - Downloading/unpacking psutil>=3.1.1 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:39 INFO - Installing collected packages: psutil 05:14:39 INFO - Running setup.py install for psutil 05:14:39 INFO - building 'psutil._psutil_linux' extension 05:14:39 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 05:14:39 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 05:14:39 INFO - building 'psutil._psutil_posix' extension 05:14:39 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 05:14:40 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 05:14:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:40 INFO - Successfully installed psutil 05:14:40 INFO - Cleaning up... 05:14:40 INFO - Return code: 0 05:14:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:14:40 INFO - Using env: {'DISPLAY': ':0', 05:14:40 INFO - 'HOME': '/home/cltbld', 05:14:40 INFO - 'LANG': 'en_US.UTF-8', 05:14:40 INFO - 'LANGUAGE': 'en_US:en', 05:14:40 INFO - 'LOGNAME': 'cltbld', 05:14:40 INFO - 'MAIL': '/var/mail/cltbld', 05:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:40 INFO - 'MOZ_NO_REMOTE': '1', 05:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:40 INFO - 'NO_EM_RESTART': '1', 05:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:40 INFO - 'PWD': '/builds/slave/test', 05:14:40 INFO - 'SHELL': '/bin/bash', 05:14:40 INFO - 'SHLVL': '1', 05:14:40 INFO - 'TERM': 'linux', 05:14:40 INFO - 'TMOUT': '86400', 05:14:40 INFO - 'USER': 'cltbld', 05:14:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:40 INFO - '_': '/tools/buildbot/bin/python'} 05:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:14:42 INFO - Installing collected packages: mozsystemmonitor 05:14:42 INFO - Running setup.py install for mozsystemmonitor 05:14:42 INFO - Successfully installed mozsystemmonitor 05:14:42 INFO - Cleaning up... 05:14:42 INFO - Return code: 0 05:14:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:42 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 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:42 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 05:14:42 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 05:14:42 INFO - Using env: {'DISPLAY': ':0', 05:14:42 INFO - 'HOME': '/home/cltbld', 05:14:42 INFO - 'LANG': 'en_US.UTF-8', 05:14:42 INFO - 'LANGUAGE': 'en_US:en', 05:14:42 INFO - 'LOGNAME': 'cltbld', 05:14:42 INFO - 'MAIL': '/var/mail/cltbld', 05:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:42 INFO - 'MOZ_NO_REMOTE': '1', 05:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:42 INFO - 'NO_EM_RESTART': '1', 05:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:42 INFO - 'PWD': '/builds/slave/test', 05:14:42 INFO - 'SHELL': '/bin/bash', 05:14:42 INFO - 'SHLVL': '1', 05:14:42 INFO - 'TERM': 'linux', 05:14:42 INFO - 'TMOUT': '86400', 05:14:42 INFO - 'USER': 'cltbld', 05:14:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:42 INFO - '_': '/tools/buildbot/bin/python'} 05:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:42 INFO - Downloading/unpacking jsonschema==2.5.1 05:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:44 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:44 INFO - warning: no files found matching '*.txt' 05:14:44 INFO - no previously-included directories found matching 'build' 05:14:44 INFO - no previously-included directories found matching 'dist' 05:14:44 INFO - no previously-included directories found matching '.git*' 05:14:44 INFO - Installing collected packages: jsonschema, functools32 05:14:44 INFO - Running setup.py install for functools32 05:14:45 INFO - warning: no files found matching '*.txt' 05:14:45 INFO - no previously-included directories found matching 'build' 05:14:45 INFO - no previously-included directories found matching 'dist' 05:14:45 INFO - no previously-included directories found matching '.git*' 05:14:45 INFO - Successfully installed jsonschema functools32 05:14:45 INFO - Cleaning up... 05:14:45 INFO - Return code: 0 05:14:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:45 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:14:45 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 functools32==3.2.3-2 05:14:45 INFO - Using env: {'DISPLAY': ':0', 05:14:45 INFO - 'HOME': '/home/cltbld', 05:14:45 INFO - 'LANG': 'en_US.UTF-8', 05:14:45 INFO - 'LANGUAGE': 'en_US:en', 05:14:45 INFO - 'LOGNAME': 'cltbld', 05:14:45 INFO - 'MAIL': '/var/mail/cltbld', 05:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:45 INFO - 'MOZ_NO_REMOTE': '1', 05:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:45 INFO - 'NO_EM_RESTART': '1', 05:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:45 INFO - 'PWD': '/builds/slave/test', 05:14:45 INFO - 'SHELL': '/bin/bash', 05:14:45 INFO - 'SHLVL': '1', 05:14:45 INFO - 'TERM': 'linux', 05:14:45 INFO - 'TMOUT': '86400', 05:14:45 INFO - 'USER': 'cltbld', 05:14:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:45 INFO - '_': '/tools/buildbot/bin/python'} 05:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:14:45 INFO - Cleaning up... 05:14:45 INFO - Return code: 0 05:14:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 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 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:45 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 05:14:45 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 05:14:45 INFO - Using env: {'DISPLAY': ':0', 05:14:45 INFO - 'HOME': '/home/cltbld', 05:14:45 INFO - 'LANG': 'en_US.UTF-8', 05:14:45 INFO - 'LANGUAGE': 'en_US:en', 05:14:45 INFO - 'LOGNAME': 'cltbld', 05:14:45 INFO - 'MAIL': '/var/mail/cltbld', 05:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:45 INFO - 'MOZ_NO_REMOTE': '1', 05:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:45 INFO - 'NO_EM_RESTART': '1', 05:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:45 INFO - 'PWD': '/builds/slave/test', 05:14:45 INFO - 'SHELL': '/bin/bash', 05:14:45 INFO - 'SHLVL': '1', 05:14:45 INFO - 'TERM': 'linux', 05:14:45 INFO - 'TMOUT': '86400', 05:14:45 INFO - 'USER': 'cltbld', 05:14:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:45 INFO - '_': '/tools/buildbot/bin/python'} 05:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:45 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 05:14:45 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 05:14:45 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 05:14:45 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 05:14:45 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 05:14:45 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 05:14:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:47 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 05:14:47 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 05:14:47 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 05:14:47 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 05:14:47 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 05:14:47 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 05:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:47 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 05:14:47 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 05:14:47 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 05:14:47 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 05:14:47 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 05:14:47 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 05:14:48 INFO - Downloading docopt-0.6.1.tar.gz 05:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:48 INFO - Running setup.py install for blobuploader 05:14:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:48 INFO - Running setup.py install for requests 05:14:48 INFO - Running setup.py install for docopt 05:14:48 INFO - Successfully installed blobuploader requests docopt 05:14:48 INFO - Cleaning up... 05:14:48 INFO - Return code: 0 05:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 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 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:48 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 05:14:48 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 05:14:48 INFO - Using env: {'DISPLAY': ':0', 05:14:48 INFO - 'HOME': '/home/cltbld', 05:14:48 INFO - 'LANG': 'en_US.UTF-8', 05:14:48 INFO - 'LANGUAGE': 'en_US:en', 05:14:48 INFO - 'LOGNAME': 'cltbld', 05:14:48 INFO - 'MAIL': '/var/mail/cltbld', 05:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:48 INFO - 'MOZ_NO_REMOTE': '1', 05:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:48 INFO - 'NO_EM_RESTART': '1', 05:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:48 INFO - 'PWD': '/builds/slave/test', 05:14:48 INFO - 'SHELL': '/bin/bash', 05:14:48 INFO - 'SHLVL': '1', 05:14:48 INFO - 'TERM': 'linux', 05:14:48 INFO - 'TMOUT': '86400', 05:14:48 INFO - 'USER': 'cltbld', 05:14:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:48 INFO - '_': '/tools/buildbot/bin/python'} 05:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:49 INFO - Running setup.py (path:/tmp/pip-mACTP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:49 INFO - Running setup.py (path:/tmp/pip-mKbWtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:49 INFO - Running setup.py (path:/tmp/pip-echFbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:49 INFO - Running setup.py (path:/tmp/pip-ZG_tib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:49 INFO - Running setup.py (path:/tmp/pip-z3AfeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:49 INFO - Running setup.py (path:/tmp/pip-O718bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:49 INFO - Running setup.py (path:/tmp/pip-CbfR8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:49 INFO - Running setup.py (path:/tmp/pip-tP9ETD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:49 INFO - Running setup.py (path:/tmp/pip-OLBF0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:49 INFO - Running setup.py (path:/tmp/pip-QPGBzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:49 INFO - Running setup.py (path:/tmp/pip-kCqRJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:49 INFO - Running setup.py (path:/tmp/pip-gZr2EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:49 INFO - Running setup.py (path:/tmp/pip-uAeumN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:50 INFO - Running setup.py (path:/tmp/pip-YzoLSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:50 INFO - Running setup.py (path:/tmp/pip-iw0ms7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:50 INFO - Running setup.py (path:/tmp/pip-vcApVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:50 INFO - Running setup.py (path:/tmp/pip-jAW7XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:50 INFO - Running setup.py install for manifestparser 05:14:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Running setup.py install for mozcrash 05:14:50 INFO - Running setup.py install for mozdebug 05:14:50 INFO - Running setup.py install for mozdevice 05:14:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Running setup.py install for mozfile 05:14:50 INFO - Running setup.py install for mozhttpd 05:14:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:50 INFO - Running setup.py install for mozinfo 05:14:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozInstall 05:14:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozleak 05:14:51 INFO - Running setup.py install for mozlog 05:14:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for moznetwork 05:14:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozprocess 05:14:51 INFO - Running setup.py install for mozprofile 05:14:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozrunner 05:14:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:51 INFO - Running setup.py install for mozscreenshot 05:14:51 INFO - Running setup.py install for moztest 05:14:51 INFO - Running setup.py install for mozversion 05:14:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:52 INFO - Cleaning up... 05:14:52 INFO - Return code: 0 05:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:52 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 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 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:52 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 05:14:52 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 05:14:52 INFO - Using env: {'DISPLAY': ':0', 05:14:52 INFO - 'HOME': '/home/cltbld', 05:14:52 INFO - 'LANG': 'en_US.UTF-8', 05:14:52 INFO - 'LANGUAGE': 'en_US:en', 05:14:52 INFO - 'LOGNAME': 'cltbld', 05:14:52 INFO - 'MAIL': '/var/mail/cltbld', 05:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:52 INFO - 'MOZ_NO_REMOTE': '1', 05:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:52 INFO - 'NO_EM_RESTART': '1', 05:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:52 INFO - 'PWD': '/builds/slave/test', 05:14:52 INFO - 'SHELL': '/bin/bash', 05:14:52 INFO - 'SHLVL': '1', 05:14:52 INFO - 'TERM': 'linux', 05:14:52 INFO - 'TMOUT': '86400', 05:14:52 INFO - 'USER': 'cltbld', 05:14:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:52 INFO - '_': '/tools/buildbot/bin/python'} 05:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 INFO - Running setup.py (path:/tmp/pip-FW7OWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 INFO - Running setup.py (path:/tmp/pip-TH2bkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:52 INFO - Running setup.py (path:/tmp/pip-W2vidY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:52 INFO - Running setup.py (path:/tmp/pip-a5XaN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:52 INFO - Running setup.py (path:/tmp/pip-aWezFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:52 INFO - Running setup.py (path:/tmp/pip-rqxgzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:52 INFO - Running setup.py (path:/tmp/pip-fVr9oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:52 INFO - Running setup.py (path:/tmp/pip-QZMYM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:52 INFO - Running setup.py (path:/tmp/pip-fmmihg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:52 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)) 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:52 INFO - Running setup.py (path:/tmp/pip-IrbugH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:53 INFO - Running setup.py (path:/tmp/pip-FXzdbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:53 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)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 INFO - Running setup.py (path:/tmp/pip-zPEG0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 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)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 INFO - Running setup.py (path:/tmp/pip-X5SMC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 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)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 INFO - Running setup.py (path:/tmp/pip-DZWbuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 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)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 INFO - Running setup.py (path:/tmp/pip-VvAPNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 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)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:53 INFO - Running setup.py (path:/tmp/pip-cCElx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:53 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)) 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:53 INFO - Running setup.py (path:/tmp/pip-lMEleB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:53 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)) 05:14:53 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)) 05:14:53 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)) 05:14:53 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)) 05:14:53 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)) 05:14:53 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)) 05:14:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:55 INFO - Downloading blessings-1.6.tar.gz 05:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:55 INFO - Installing collected packages: blessings 05:14:55 INFO - Running setup.py install for blessings 05:14:55 INFO - Successfully installed blessings 05:14:55 INFO - Cleaning up... 05:14:55 INFO - Return code: 0 05:14:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:55 INFO - Reading from file tmpfile_stdout 05:14:55 INFO - Current package versions: 05:14:55 INFO - argparse == 1.2.1 05:14:55 INFO - blessings == 1.6 05:14:55 INFO - blobuploader == 1.2.4 05:14:55 INFO - docopt == 0.6.1 05:14:55 INFO - functools32 == 3.2.3-2 05:14:55 INFO - jsonschema == 2.5.1 05:14:55 INFO - manifestparser == 1.1 05:14:55 INFO - mozInstall == 1.12 05:14:55 INFO - mozcrash == 0.17 05:14:55 INFO - mozdebug == 0.1 05:14:55 INFO - mozdevice == 0.48 05:14:55 INFO - mozfile == 1.2 05:14:55 INFO - mozhttpd == 0.7 05:14:55 INFO - mozinfo == 0.9 05:14:55 INFO - mozleak == 0.1 05:14:55 INFO - mozlog == 3.3 05:14:55 INFO - moznetwork == 0.27 05:14:55 INFO - mozprocess == 0.23 05:14:55 INFO - mozprofile == 0.28 05:14:55 INFO - mozrunner == 6.12 05:14:55 INFO - mozscreenshot == 0.1 05:14:55 INFO - mozsystemmonitor == 0.3 05:14:55 INFO - moztest == 0.7 05:14:55 INFO - mozversion == 1.4 05:14:55 INFO - psutil == 3.1.1 05:14:55 INFO - requests == 1.2.3 05:14:55 INFO - wsgiref == 0.1.2 05:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:55 INFO - Using env: {'DISPLAY': ':0', 05:14:55 INFO - 'HOME': '/home/cltbld', 05:14:55 INFO - 'LANG': 'en_US.UTF-8', 05:14:55 INFO - 'LANGUAGE': 'en_US:en', 05:14:55 INFO - 'LOGNAME': 'cltbld', 05:14:55 INFO - 'MAIL': '/var/mail/cltbld', 05:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:55 INFO - 'MOZ_NO_REMOTE': '1', 05:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:55 INFO - 'NO_EM_RESTART': '1', 05:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:55 INFO - 'PWD': '/builds/slave/test', 05:14:55 INFO - 'SHELL': '/bin/bash', 05:14:55 INFO - 'SHLVL': '1', 05:14:55 INFO - 'TERM': 'linux', 05:14:55 INFO - 'TMOUT': '86400', 05:14:55 INFO - 'USER': 'cltbld', 05:14:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:55 INFO - '_': '/tools/buildbot/bin/python'} 05:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 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)) 05:14:56 INFO - Cleaning up... 05:14:56 INFO - Return code: 0 05:14:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:56 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 0x1576030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1837180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', '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 05:14:56 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 05:14:56 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 05:14:56 INFO - Using env: {'DISPLAY': ':0', 05:14:56 INFO - 'HOME': '/home/cltbld', 05:14:56 INFO - 'LANG': 'en_US.UTF-8', 05:14:56 INFO - 'LANGUAGE': 'en_US:en', 05:14:56 INFO - 'LOGNAME': 'cltbld', 05:14:56 INFO - 'MAIL': '/var/mail/cltbld', 05:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:56 INFO - 'MOZ_NO_REMOTE': '1', 05:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:56 INFO - 'NO_EM_RESTART': '1', 05:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:56 INFO - 'PWD': '/builds/slave/test', 05:14:56 INFO - 'SHELL': '/bin/bash', 05:14:56 INFO - 'SHLVL': '1', 05:14:56 INFO - 'TERM': 'linux', 05:14:56 INFO - 'TMOUT': '86400', 05:14:56 INFO - 'USER': 'cltbld', 05:14:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:56 INFO - '_': '/tools/buildbot/bin/python'} 05:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:14:56 INFO - Cleaning up... 05:14:56 INFO - Return code: 0 05:14:56 INFO - Running post-action listener: _resource_record_post_action 05:14:56 INFO - Running post-action listener: _start_resource_monitoring 05:14:56 INFO - Starting resource monitoring. 05:14:56 INFO - [mozharness: 2016-08-09 12:14:56.349123Z] Finished create-virtualenv step (success) 05:14:56 INFO - [mozharness: 2016-08-09 12:14:56.349659Z] Running install step. 05:14:56 INFO - Running pre-action listener: _resource_record_pre_action 05:14:56 INFO - Running main action method: install 05:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:56 INFO - Reading from file tmpfile_stdout 05:14:56 INFO - Detecting whether we're running mozinstall >=1.0... 05:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:14:56 INFO - Reading from file tmpfile_stdout 05:14:56 INFO - Output received: 05:14:56 INFO - Usage: mozinstall [options] installer 05:14:56 INFO - Options: 05:14:56 INFO - -h, --help show this help message and exit 05:14:56 INFO - -d DEST, --destination=DEST 05:14:56 INFO - Directory to install application into. [default: 05:14:56 INFO - "/builds/slave/test"] 05:14:56 INFO - --app=APP Application being installed. [default: firefox] 05:14:56 INFO - mkdir: /builds/slave/test/build/application 05:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:15:13 INFO - Reading from file tmpfile_stdout 05:15:13 INFO - Output received: 05:15:13 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:13 INFO - Running post-action listener: _resource_record_post_action 05:15:13 INFO - [mozharness: 2016-08-09 12:15:13.706042Z] Finished install step (success) 05:15:13 INFO - [mozharness: 2016-08-09 12:15:13.706378Z] Running run-tests step. 05:15:13 INFO - Running pre-action listener: _resource_record_pre_action 05:15:13 INFO - Running main action method: run_tests 05:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:13 INFO - Python 2.7.3 05:15:13 INFO - Return code: 0 05:15:13 INFO - grabbing minidump binary from tooltool 05:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:13 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 0x18353b0>, '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 0x18362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1836740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:13 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 05:15:13 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 05:15:13 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 05:15:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:13 INFO - Return code: 0 05:15:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:13 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/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:15:13 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/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 05:15:13 INFO - Using env: {'DISPLAY': ':0', 05:15:13 INFO - 'HOME': '/home/cltbld', 05:15:13 INFO - 'LANG': 'en_US.UTF-8', 05:15:13 INFO - 'LANGUAGE': 'en_US:en', 05:15:13 INFO - 'LOGNAME': 'cltbld', 05:15:13 INFO - 'MAIL': '/var/mail/cltbld', 05:15:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:13 INFO - 'MOZ_NO_REMOTE': '1', 05:15:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:13 INFO - 'NO_EM_RESTART': '1', 05:15:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:13 INFO - 'PWD': '/builds/slave/test', 05:15:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:13 INFO - 'SHELL': '/bin/bash', 05:15:13 INFO - 'SHLVL': '1', 05:15:13 INFO - 'TERM': 'linux', 05:15:13 INFO - 'TMOUT': '86400', 05:15:13 INFO - 'USER': 'cltbld', 05:15:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717', 05:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:13 INFO - '_': '/tools/buildbot/bin/python'} 05:15:13 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/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 05:15:13 INFO - mozversion application_buildid: 20160809023001 05:15:13 INFO - mozversion application_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 05:15:13 INFO - mozversion application_display_name: Nightly 05:15:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:13 INFO - mozversion application_name: Firefox 05:15:13 INFO - mozversion application_remotingname: firefox 05:15:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:15:13 INFO - mozversion application_vendor: Mozilla 05:15:13 INFO - mozversion application_version: 51.0a1 05:15:13 INFO - mozversion platform_buildid: 20160809023001 05:15:13 INFO - mozversion platform_changeset: 2edc35144ebf50ca6339e686e766e200cc4b04b8 05:15:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:15:13 INFO - mozversion platform_version: 51.0a1 05:15:13 INFO - using testdate: 1470744913 05:15:13 INFO - actual date: 1470744913 05:15:13 INFO - starting webserver on 'localhost:33846' 05:15:13 INFO - SUITE-START | Running 2 tests 05:15:13 INFO - TEST-START | dromaeo_css 05:15:13 INFO - operating with platform_type : linux_ 05:15:13 INFO - Initialising browser for dromaeo_css test... 05:15:13 INFO - TEST-INFO | started process 28361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1h5Oxv/profile http://localhost:33846/getInfo.html) 05:15:18 INFO - PROCESS | 28361 | __metrics Screen width/height:1600/1200 05:15:18 INFO - PROCESS | 28361 | colorDepth:24 05:15:18 INFO - PROCESS | 28361 | Browser inner width/height: 1024/697 05:15:18 INFO - PROCESS | 28361 | __metrics 05:15:18 INFO - PROCESS | 28361 | 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" 05:15:18 INFO - PROCESS | 28361 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:19 INFO - PROCESS | 28361 | console.error: PushService: 05:15:19 INFO - PROCESS | 28361 | stateChangeProcessEnqueue: Error transitioning state 05:15:19 INFO - PROCESS | 28361 | UnknownError 05:15:19 INFO - TEST-INFO | 28361: exit 0 05:15:19 INFO - Browser initialized. 05:15:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:19 INFO - TEST-INFO | started process 28444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1h5Oxv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:31 INFO - PROCESS | 28444 | RSS: Main: 156508160 05:15:31 INFO - PROCESS | 28444 | 05:16:22 INFO - PROCESS | 28444 | 1470744982748 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] 05:18:32 INFO - PROCESS | 28444 | Cycle 1(1): loaded http://localhost:33846/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33846/tests/dromaeo/cssquery-ext.html) 05:18:33 INFO - PROCESS | 28444 | RSS: Main: 283267072 05:18:33 INFO - PROCESS | 28444 | 05:21:36 INFO - PROCESS | 28444 | Cycle 1(1): loaded http://localhost:33846/tests/dromaeo/cssquery-ext.html (next: http://localhost:33846/tests/dromaeo/cssquery-jquery.html) 05:21:36 INFO - PROCESS | 28444 | RSS: Main: 240443392 05:21:36 INFO - PROCESS | 28444 | 05:24:38 INFO - PROCESS | 28444 | Cycle 1(1): loaded http://localhost:33846/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33846/tests/dromaeo/cssquery-mootools.html) 05:24:39 INFO - PROCESS | 28444 | RSS: Main: 228896768 05:24:39 INFO - PROCESS | 28444 | 05:27:41 INFO - PROCESS | 28444 | Cycle 1(1): loaded http://localhost:33846/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33846/tests/dromaeo/cssquery-prototype.html) 05:27:41 INFO - PROCESS | 28444 | RSS: Main: 222662656 05:27:41 INFO - PROCESS | 28444 | 05:30:44 INFO - PROCESS | 28444 | Cycle 1(1): loaded http://localhost:33846/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33846/tests/dromaeo/cssquery-yui.html) 05:30:44 INFO - PROCESS | 28444 | RSS: Main: 188522496 05:30:44 INFO - PROCESS | 28444 | 05:33:47 INFO - PROCESS | 28444 | Cycle 1(1): loaded http://localhost:33846/tests/dromaeo/cssquery-yui.html (next: http://localhost:33846/tests/dromaeo/cssquery-dojo.html) 05:33:48 INFO - PROCESS | 28444 | RSS: Main: 276795392 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | __start_tp_report 05:33:48 INFO - PROCESS | 28444 | _x_x_mozilla_page_load 05:33:48 INFO - PROCESS | 28444 | _x_x_mozilla_page_load_details 05:33:48 INFO - PROCESS | 28444 | |i|pagename|runs| 05:33:48 INFO - PROCESS | 28444 | |0;dojo.html;3018.592490013848;3033.120395085425;3046.238440389901;3046.4364092642854;3051.908442746717;5189.351331083614;5247.553957913582;5287.101192797224;5346.652467589604;5383.62314637975;5289.947100528993;5327.041132596131;5370.113931201347;5390.460953904608;5449.754761035753;4794;4800.855974320776;4820.445648750386;4833.250846118857;4991.550760431561;4911.410630724318;4936.185529387647;4940.481249468808;4949.109160351135;4955.182394904837;4717.410323709536;4769.546893045155;4778.139934811733;4865.099956508057;4865.708057516543;4808.735519546423;4818.903621927542;4820.758962051884;4822.807087716487;4837.250226214907;4736.9526304736855;4782.378290822171;4794.736289504076;4794.95205047952;4824.421069471651;5221.347331583552;5272.499112584298;5273.2617433559335;5349.491798279158;5371.838844834661;5717.285339332583;5724.112762521774;5729.312482502127;5766.596338256324;5767.452092051249;5439.3200849893765;5700.087985922232;5733.369329373765;5751.827445176609;5789.16057171712;5366.570674346043;5389.757460914268;5393.8112166074;5406.432324605899;5406.486383793534;5916.645001299936;5929.881402371929;5931.288245410492;5933.465988061009;5937.465628093492;5332.360116785933;5454.154606036071;5467.1799230115;5520.558355331564;5674.290713660793;5606.411326810708;5644.604877658525;5645.971770141123;5653.491185793298;5662.773489060474;5590.273264475592;5592.636478628876;5593.804216852472;5595.160725891149;5600.047991841397;5490.450954904478;5586.329640443173;5613.045782217033;5613.214150019001;5650.378458369576;4302.376155457441;4307.504636966726;4307.978460107742;4345;4352.847650332224;3799.4110912808005;3815.751976121543;3827.138893748884;3849.172427927953;3861.1698484825897;5159.097157997336;5331.733413329318;5372.1941708744;5389.02997460453;5442.2380866678695;5779.306483222041;5795.536357091422;5805.187273781674;5817.156512305692;5857.47282744555;5408.161734931092;5428.864278393072;5443.292371991695;5445.53712934405;5446.346438427414;4737;4785.641076919245;4934.259861020875;4942.20924652054;4996.90006199874;5791;5883.735231914488;5903.675297858659;5919.970400148058;5944.019236825961;5645.548356131418;5657.519110875457;5659.26429564154;5663.122216056518;5665.320161580472;5756.136579513107;5858.414158584107;5862.384449632727;5868.589198756046;5893.734781934909;5593.4126916674795;5627.718614069362;5635.323761148688;5675.517581005495;5686.886262274814;5711.057675483665;5748.511376532874;5761.251037365116;5767.625104368202;5767.826965191051;5432.674039557481;5538.889222215453;5569.220309156803;5617.747201375866;5617.8033768817895;5559;5577.107662773937;5590.552755779447;5618.073017951992;5647.20939068539;5518.33779946409;5520.06158952971;5527.281453411031;5531.419200983839;5534.7786088556;5452.018636645442;5551.167324901297;5669.34802497718;5690.715464226855;5693.943060569507;5424.566034717134;5499;5501.119820828648;5538.556915446674;5547.195656629686 05:33:48 INFO - PROCESS | 28444 | |1;ext.html;583.6177303865967;601.2634522709682;608.7352001879183;613.4908026338138;616.8457885528618;42804.78597607012;43841.561584384144;43845.56154438459;43853.56146438535;47670.76164619172;45062.54937450625;45403.77298113505;45473.31790023152;45518;45632.771836140855;8877.86683199751;9037.051109633492;9040.954795226015;9047.683331083414;9052.41159324645;8948.463092214488;9015.95492022539;9046.502442365667;9048.592813323416;9049.95475022624;9118.13377729118;9137.451752894847;9160.129787670161;9160.816783664355;9168.129027742387;9050.366474346798;9090.681826136053;9091.31815113869;9092.8636070459;9093;8904.643814247422;9032.593533291018;9034.32242581809;9044.728658140266;9047.773805654846;41425.79287103545;41961.37057944103;41963.7901810489;42060.158796824195;42064.78967605143;3600.6219346968455;4004.6796256299426;4192.748435093874;4328.480582330109;4444.866654000385;32866.849660261774;33346.83326583376;33374.666253337644;33508.83245583781;33845.6615433845;4266.87199384019;4399.340098985146;4406.449193850769;4536.4102666653125;4540.682152249344;248986;249650.75174624193;253905;254456;256879;54846;54923.72538137284;54960.17559736607;55305.723471382385;55414;58373;58630.413695862495;58669.70665146647;58736.412635873094;58812.7059364709;14221.28893555318;14263.85736142646;14316;14348.928255358865;14359.210243436712;12062.577809776616;12134.453949572291;12162.08784341178;12163.331016793984;12164;12436.258923750682;15816.130112843904;15816.446424375321;15864;16144.75782863258;5379.65032272901;6243.562950593415;6502.219733631994;6534.967325163344;6701.731930722814;1026.2918586175515;1057.5346847387125;1086.6414083352474;1088.2545456362418;1125.7973564758258;31242.21894452657;32510;33089.3382132356;33217;33658.831705841316;1128.1595211567435;1132.7621199548023;1143.7369405036889;1152.1589239854952;1195.0678470792795;16875.746863797052;17400.21699023547;17414.564635884206;17421.738673919903;17591.96524650274;514921;515256;515599;515795;520984;55428.72285638546;55637.44362556404;55653.165202521996;55730;55784.16323755147;1232.4084439469104;1323.8146659467682;1358.8505264420905;1370.9931450342685;1381.6753063029978;32514.349713005133;33752;34319.4852077214;34385.82807086049;34463.65536344604;49583.25625115554;49975;50163;50228;50265.49734502608;404814;406841;407165;407226;409365;27777.861110694317;27926.44147117087;28290;28605.570916435852;41842.79078604587;43969;44070;47279.29081063856;47401;48077.27884081672;38447.80776096102;39765.80117099512;40420.716016689206;40502.1899562013;41678.583214168684;39924.20151596894;40661.390079148245;40743.388849166695;41949.58050419579;42360.36459453049;40182.39726404165;41044.38433423441;41491;41607;42264;34770.478442823885;36503.45244821277;36853.54366735097;36917.63082369142;37176.81411592925;27980.30049248785;28220.730067147437;28379.716202837706;28507.28731781722;28593.28516787097 05:33:48 INFO - PROCESS | 28444 | |2;jquery.html;370.9406494960807;378.9374753165728;386.88780253726424;393.82671624485226;418.6253303293552;17323.653526929455;19659.606807863853;19737.901310493427;19913.103910324033;20735.896320518415;19843;20066.197352105934;20078.59842803143;20264;20581.27965521207;5214.791408343662;5731.713414329288;5872.236609240793;5916.467517923386;5940;5728.68492232927;5770.509506691937;5802.738876750535;5815.651060936336;5818.621789583684;5638.210650508911;5773.826785196451;5845.152452894349;5867.354590994987;5869.295684517842;5664.631798933056;5866.5306775458075;5905.645661260295;5911.704414779244;5915.674637894914;5215.582753379758;5248.763805628756;5254.92117618236;5255.264263003182;5257.764425360037;24583.63124553133;24630;24908.626370604274;24949.126780562776;24980.250592482254;2370.111208296889;2467.6668649732414;3058.6023816903885;3178.586783718125;3195.3769015042076;14505.202213878232;15024.17367044812;15031.098134111879;15255;15466.61333466661;1889;1912.3880358285355;1963.980360196394;2025.1595587831032;2057.5164836263466;66642.66678666625;81431;83810;84043;86112.81928216873;10850.728731781768;11027.117830573536;11268.943655281671;11398.943005285086;11426;15445.382184712485;15457.072575645498;15474.148921809183;15491.612709682347;15500.30248638814;7403.148637906602;7456.664450099758;7884.053913530298;7903.446758726949;8031.196880311922;6941.757038503628;7541.057367829021;7849.979502664617;8049.718259860877;8106.432549721463;6772.153480814898;6876.724931002704;6903.1371078615175;6904.758333458305;6929.653517324114;1956.7162761399802;1974.4767636576319;1994.3917105282737;2015.981929125782;2023.352527191314;909.6997990663066;948.0756262643868;1001.9398836069859;1073.5169173871789;1161.872194058653;20689.379318620464;21107.577848442947;21327.146914123572;21373.552972025205;21447.14211431525;1026.3328836256344;1061.5170097605571;1083.685731137961;1101.251149218539;1131.134681968295;11127.499262533205;12023.21849079807;12106.576269830513;12187.939060304641;12248.755024899452;368010;372530;375138;476038;483448;74690.62654686692;98716;101938;102820;105381;1004.5579944824254;1008.6318493749728;1037.3775734559356;1043.2280112716535;1058.216919479595;18632.906835465736;18821.717674234624;19590.510237243612;19597.31409400664;19672.704909426655;32211.033668989967;37340;42778.57221427746;45157.548424515335;45772;63437.682811587496;63483;63864.68067659632;64248.357516426106;66168;8401.70594029206;8684.261837743863;8907.821843562962;8972.820543589221;9161.587728552098;12738.936305318413;13568.38942247621;13630.727385452037;13661;13903.374348154559;12017.699557511132;12044.879551204725;12133.272003679807;12165.75668486643;12275.508979641072;11676.416179191176;11699.88300116988;11709.365392786554;11795.29228246308;12008.459619316976;11841;12019.278843269432;12211.877881221075;12335;12614.053945953907;8664.436811607226;8751.693690720795;8801.515916624647;8860.006498538036;8883.42257753244;9462.479563624067;10881.183911206534;11079.501422436171;11173.05029072538;11407.486663100346 05:33:48 INFO - PROCESS | 28444 | |3;mootools.html;1367.248013592525;1473.9336729847155;1517.9165145916973;1576.2118940529735;1734.028943791476;8339.457935234213;8701.434406763556;8804.647814087444;9160.26717862571;9160.816783664322;8949.194572488475;9039.412438191514;9047.321450891193;9049.683261085864;9052.45685258885;2351.329870986769;2390.725066617335;2392.7966122879575;2395.317334559651;2395.6765836612094;2349.1543044503965;2377.988110059447;2406.302172370011;2412.7707867752533;2416.1664225842055;2351.49442869783;2375.7386687464364;2383.4279772854475;2385.7733515316017;2389.844660097097;2243.1139699818646;2282.669012993115;2288.656701494781;2289.8740569268766;2343.1798870395223;2286.216750934274;2310.572544079351;2310.849794763335;2314.6990891184037;2317.084751523139;7723.343515801163;8923.910760892373;9054.818903621957;9121.087891210826;9168.129027742354;5080.74596270185;5258.447862974371;5286.762095705664;5371.462853714636;5381.13901775714;3468.601110872257;3491;3543.450765131409;3550.041488798036;3569.821508924543;1228.6928267933017;1230.593904011683;1230.9015278777676;1247.2516490105954;1255.8367412236441;12661.36693165338;12676.049296302814;12686.873131268754;12693.809592856114;12704.04719646021;4427.468703755506;4678.649101317346;4736.123817093849;4850.296706977469;4852.902941941142;10532.684019479428;10538.525766340534;10543.94728026355;10546;10550.261481696207;5361.785528578813;5365.839024829262;5367.355917289872;5369.24830523727;5373.489518495737;4826.58973987215;4925.581325587294;4930.063287975273;4933.654644174873;4941.382327209099;3855.7108216883285;3910.178862438863;3977.8209980550946;4012.0371110933165;4012.578679238696;1200.6158029430674;1200.8018676918384;1202.837616921722;1217.9391030448442;1228.3489750432286;937.3485427627734;961.7451375385529;969.2682025071026;976.5995941663883;991.9603215871284;5700.572457065737;5761.740721667535;5811.680357580373;5834.27071616048;5936.940630593639;460.7419844886874;463.48321621391904;465.3206318774627;469.3312030356728;482.995170048295;3913.1391093959282;3946.1515774108702;3971.980140099281;4046.9797651012145;4138.172365526907;10076.143527800219;10174.745631359276;10282.485875706185;10408.907064758243;10889.564417423215;10516.3690178588;10625.203109766799;10628.627998020032;10630.043296103388;10638.627648032281;8078.555679437687;8167.714130005421;8210.384221183434;8218.178182181735;8234.876476852853;5971.940280597139;6006.819795406145;6026.276846778414;6028.367021462684;6193.752249909953;9351.205147562534;9659.034096590285;9674.564644591152;9717.951410242904;9777.9022209777;10107.444090575089;10110.241731870286;10119.848202277119;10125.291229613857;10143.239257055602;7358.742444014434;7374.225706300976;7385.9261407387385;7391.186969433251;7443.4789564729945;8302.169783021649;8393.454425462325;8398.454100483448;8471.788205294917;8482.109378515168;7588.8482230353975;7610.505317154367;7671.578063206354;7685.615719214129;7787.10448298453;7343.522671026366;7421.443391745533;7456;7504.099508059068;7557.2820582044615;6632.403083722488;6689.598624082376;6696.1629796275465;6712.2616512184595;6766.086578311865;5224.242484839753;5251.448597897319;5290.365156181283;5378.40837507866;5380.865478363072;5069.6197785167;5090.2364645303505;5269.947300526946;5282.6038047147385;5301.628885977944 05:33:48 INFO - PROCESS | 28444 | |4;prototype.html;311.68519795007035;326.091834241637;330.118583382369;331.10931594012123;333.2934179539377;5220.530152286294;5226.8693282667855;5254.973725131369;5266.789328426863;5267.710275934832;4887.608991280698;4977.427595826481;5151.072806894757;5164.845054648357;5177.378714554259;4114.506259248879;4119.40268661044;4121.113960498492;4142.896427589304;4146.6268035876765;4120.6195924365375;4130.566290539495;4142.653637567802;4147.336426171813;4155.148194620096;3910.178862438877;3923.9215215695667;4077.368007958756;4077.5922407759285;4091.3453847384426;4083.509978802533;4089.9795501022454;4101.85643502476;4104.91790164195;4112.437273835923;3655.7204978257664;3658.414653655429;3661.5423072115987;3661.8718344857803;3683.723720720957;5009.874753131201;5052.671576347562;5074.720890351029;5150.227465880111;5150.845474635729;4670.743109128996;4677.812887484531;4698.976505117486;4722.220833562493;4729.9763501182615;5361.2226227197225;5381.5425688816495;5397.325334333208;5427.592930530226;5457.263269458612;3746.812659367048;3927.7054220933546;4019.336809426441;4027.35562310029;4030.9193816123807;5612.270404847343;5621.7189140542805;5624.184493248497;5628.465295796934;5647;4026.9999999999413;4041.2725709372594;4043.272211001989;4045.1707399982934;4048.959510404858;3857.4599556062176;4113.71204015716;4116.403121547359;4122.175564887035;4133.379993001074;4550.2492088804975;4581.839635612738;4582.28974508945;4626.606738427204;4631.745254011062;5382.596305277119;5398.568114550826;5403.459654034565;5464.726763661881;5468.207109969032;1364.986350136486;1385.2658091211674;1397.4410235905718;1399;1409.5559898631898;901.1799262670938;916.1525588830306;920.8857282687889;926.7173512078881;941.275218082073;4719.339292499053;4728.976355118202;4787.497312782178;4787.497312782178;4804.639652026042;4949.90100197994;4966.329545511382;4974.527419895104;4982.202847544448;4983.825566105169;4483.349914262414;4627.3521706961055;4652.302154676758;4668.253079507263;4680.040591678766;2637.5648018076804;2641.4056837211856;2644.3917898883365;2647.9805274969276;2657.2958166086005;5132.56373208274;5162.6902385856965;5176.404713457925;5196.194589838581;5216.556592689588;4869.342638743724;4898.632602554822;4961.320886721202;5042.369703787027;5045.587235574045;5093.541581257705;5131.384233891957;5139.383274007068;5153.381594208644;5175.792968281226;4848.490908454703;4921.950780492292;4939.50554969738;4977.676451030671;4981;4568.954310456853;4824;4836.637252206169;4846.95153048465;4848.903021939612;5097.1844504879045;5118.155504341891;5122.231665250242;5162.354705661793;5220.269162317354;3721.404575267944;3732.2348918471107;3742.1393079591303;3743.213925075656;3751.15598990225;5059.772310246121;5186.740662966912;5578.888422231614;5611.466910643482;5617.8033768817895;5470.671759694431;5471.835844924659;5487.670739755627;5489.204065410573;5491.75287112073;5212.348456442945;5475.09660905946;5483.835484935458;5542.944570554404;5560.304961879765;5403.459654034565;5405.5135037846785;5432.821799247485;5433.9184912225555;5448.338256831546;5490.066688663017;5506.339239291311;5521.668699878021;5555.944440555542;5563.693996830213;5164.1995490699;5368.436314186954;5395.514403703685;5419.918701219563;5436.619436639556 05:33:48 INFO - PROCESS | 28444 | |5;yui.html;730.9524880882742;738.8743913534698;761.4213197969541;770.2643975003872;810.5744484145823;15301.846981530181;16129.354825806982;16291.999999999985;16293.59266018347;16342.264598093085;14772.704545909075;14879.256037198124;14887.776683349759;14921.776173357408;14972.401103955828;658.3317932298721;776.0919723922996;782.295933659708;796.366888323781;798.6286376834771;797.5533701127388;807.588130053671;814.1736137820118;814.7392834293029;814.9592520373958;864.9654013839439;867.4014929698519;867.8828358171661;868.2836659755695;868.4658934755143;692.6813665713778;837.7528629054383;864.7794812322849;865.212656482601;865.4028720183054;624.0888303077512;629.351767679291;629.5561629051508;632.5508888689036;634.1249076274711;14843.703125937422;14877.925610371987;14924.477643282542;14984.82720005593;15021.098734075882;15464.149471779048;15674.608134796606;15682.68634627301;15834.683306333924;16015.759763603555;12635.494580216871;12676.746465070739;12690.175138615961;12743.235405875677;12883.67790805228;3896.8636097736726;3978.3236849735613;4021.396790481422;4044;4175.853845115406;67495.32504674939;68299.31700683029;69530.3046969529;83247;83487.16512834854;11434.256773309708;11796.115291353182;11907.226030308175;11989.700257493458;12177;21873.234436794955;22035.567688100222;22127.33617991463;22144.114235430723;22245.55508889813;8519;8608.09614990417;8790.516521591373;8924.821503569892;8945;4765.213739732905;4831.4685384607665;4837.975810120997;4898.779554920037;5002.074616196015;3397.473391624302;3502.264524449843;3507.94738078929;3513.297340531904;3520.1375662962737;587.4155215560545;594.6224147666263;599.3946114424375;600.342624825815;609.6585911889267;678.555546117284;708.929107089287;710.4139085254685;712.7434123715458;716.4984510842327;9297;9533.761655958657;9621.326507144433;9822.312438129406;10027.749306267257;663.9966800165968;692.6882902693808;699.1016543741268;722.5592388642924;726.8255618651591;4368.584984426474;4393.780310984438;4584.541545845455;4670.346151538719;4671.15919134559;70138.64930675416;72208.63895680488;94857.525712371;127994;130483.69516304716;106690.19717633934;107664;108003.45998269958;109794.45102774595;112910.43544782224;59151.408485915454;80914.59542702249;96804.51597741967;99137;101045;9481.383710058824;9664.565094570902;9814.889798693315;9834.803303933739;10122;54412;54950.9999999984;56707.43292567186;56892;57947.4205257942;47704;70014.64992675003;77078;77183.61408193148;79162;12061.276323420623;12099.81850272229;12104.213226140273;12224.75550489003;12612.87387126117;15302.311395986984;15345.693086137991;15408.537743867702;15491.922540387226;15608.765868511755;12748.298843563693;13724.382402791698;14074.366653500412;14604.342804574033;14639.268036597914;14126.717465650834;14470.20413877247;14561.563153105424;14713.779293310823;14740.189289589176;12321.445534951128;12402.441890114786;12409.44157512896;12871.485140594272;13025.283609401195;11408;11453.19827612059;11484.192632314307;11617.419129043345;11876.465559049691;10581.4709264538;11252.887471125185;11327.263727857662;11441.544833092294;11887.346195959306 05:33:48 INFO - PROCESS | 28444 | __end_tp_report 05:33:48 INFO - PROCESS | 28444 | __start_cc_report 05:33:48 INFO - PROCESS | 28444 | _x_x_mozilla_cycle_collect,1050 05:33:48 INFO - PROCESS | 28444 | __end_cc_report 05:33:48 INFO - PROCESS | 28444 | __startTimestamp1470746028226__endTimestamp 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | ------- Summary: start ------- 05:33:48 INFO - PROCESS | 28444 | Number of tests: 6 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | [#0] dojo.html Cycles:165 Average:5286.39 Median:5490.45 stddev:614.02 (11.2%) stddev-sans-first:589.57 05:33:48 INFO - PROCESS | 28444 | Values: 3018.6 3033.1 3046.2 3046.4 3051.9 5189.4 5247.6 5287.1 5346.7 5383.6 5289.9 5327.0 5370.1 5390.5 5449.8 4794.0 4800.9 4820.4 4833.3 4991.6 4911.4 4936.2 4940.5 4949.1 4955.2 4717.4 4769.5 4778.1 4865.1 4865.7 4808.7 4818.9 4820.8 4822.8 4837.3 4737.0 4782.4 4794.7 4795.0 4824.4 5221.3 5272.5 5273.3 5349.5 5371.8 5717.3 5724.1 5729.3 5766.6 5767.5 5439.3 5700.1 5733.4 5751.8 5789.2 5366.6 5389.8 5393.8 5406.4 5406.5 5916.6 5929.9 5931.3 5933.5 5937.5 5332.4 5454.2 5467.2 5520.6 5674.3 5606.4 5644.6 5646.0 5653.5 5662.8 5590.3 5592.6 5593.8 5595.2 5600.0 5490.5 5586.3 5613.0 5613.2 5650.4 4302.4 4307.5 4308.0 4345.0 4352.8 3799.4 3815.8 3827.1 3849.2 3861.2 5159.1 5331.7 5372.2 5389.0 5442.2 5779.3 5795.5 5805.2 5817.2 5857.5 5408.2 5428.9 5443.3 5445.5 5446.3 4737.0 4785.6 4934.3 4942.2 4996.9 5791.0 5883.7 5903.7 5920.0 5944.0 5645.5 5657.5 5659.3 5663.1 5665.3 5756.1 5858.4 5862.4 5868.6 5893.7 5593.4 5627.7 5635.3 5675.5 5686.9 5711.1 5748.5 5761.3 5767.6 5767.8 5432.7 5538.9 5569.2 5617.7 5617.8 5559.0 5577.1 5590.6 5618.1 5647.2 5518.3 5520.1 5527.3 5531.4 5534.8 5452.0 5551.2 5669.3 5690.7 5693.9 5424.6 5499.0 5501.1 5538.6 5547.2 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | [#1] ext.html Cycles:180 Average:55978.38 Median:23071.16 stddev:107854.59 (467.5%) stddev-sans-first:108076.96 05:33:48 INFO - PROCESS | 28444 | Values: 583.6 601.3 608.7 613.5 616.8 42804.8 43841.6 43845.6 43853.6 47670.8 45062.5 45403.8 45473.3 45518.0 45632.8 8877.9 9037.1 9041.0 9047.7 9052.4 8948.5 9016.0 9046.5 9048.6 9050.0 9118.1 9137.5 9160.1 9160.8 9168.1 9050.4 9090.7 9091.3 9092.9 9093.0 8904.6 9032.6 9034.3 9044.7 9047.8 41425.8 41961.4 41963.8 42060.2 42064.8 3600.6 4004.7 4192.7 4328.5 4444.9 32866.8 33346.8 33374.7 33508.8 33845.7 4266.9 4399.3 4406.4 4536.4 4540.7 248986.0 249650.8 253905.0 254456.0 256879.0 54846.0 54923.7 54960.2 55305.7 55414.0 58373.0 58630.4 58669.7 58736.4 58812.7 14221.3 14263.9 14316.0 14348.9 14359.2 12062.6 12134.5 12162.1 12163.3 12164.0 12436.3 15816.1 15816.4 15864.0 16144.8 5379.7 6243.6 6502.2 6535.0 6701.7 1026.3 1057.5 1086.6 1088.3 1125.8 31242.2 32510.0 33089.3 33217.0 33658.8 1128.2 1132.8 1143.7 1152.2 1195.1 16875.7 17400.2 17414.6 17421.7 17592.0 514921.0 515256.0 515599.0 515795.0 520984.0 55428.7 55637.4 55653.2 55730.0 55784.2 1232.4 1323.8 1358.9 1371.0 1381.7 32514.3 33752.0 34319.5 34385.8 34463.7 49583.3 49975.0 50163.0 50228.0 50265.5 404814.0 406841.0 407165.0 407226.0 409365.0 27777.9 27926.4 28290.0 28605.6 41842.8 43969.0 44070.0 47279.3 47401.0 48077.3 38447.8 39765.8 40420.7 40502.2 41678.6 39924.2 40661.4 40743.4 41949.6 42360.4 40182.4 41044.4 41491.0 41607.0 42264.0 34770.5 36503.5 36853.5 36917.6 37176.8 27980.3 28220.7 28379.7 28507.3 28593.3 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | [#2] jquery.html Cycles:180 Average:27630.69 Median:13476.87 stddev:69629.07 (516.7%) stddev-sans-first:69794.32 05:33:48 INFO - PROCESS | 28444 | Values: 370.9 378.9 386.9 393.8 418.6 17323.7 19659.6 19737.9 19913.1 20735.9 19843.0 20066.2 20078.6 20264.0 20581.3 5214.8 5731.7 5872.2 5916.5 5940.0 5728.7 5770.5 5802.7 5815.7 5818.6 5638.2 5773.8 5845.2 5867.4 5869.3 5664.6 5866.5 5905.6 5911.7 5915.7 5215.6 5248.8 5254.9 5255.3 5257.8 24583.6 24630.0 24908.6 24949.1 24980.3 2370.1 2467.7 3058.6 3178.6 3195.4 14505.2 15024.2 15031.1 15255.0 15466.6 1889.0 1912.4 1964.0 2025.2 2057.5 66642.7 81431.0 83810.0 84043.0 86112.8 10850.7 11027.1 11268.9 11398.9 11426.0 15445.4 15457.1 15474.1 15491.6 15500.3 7403.1 7456.7 7884.1 7903.4 8031.2 6941.8 7541.1 7850.0 8049.7 8106.4 6772.2 6876.7 6903.1 6904.8 6929.7 1956.7 1974.5 1994.4 2016.0 2023.4 909.7 948.1 1001.9 1073.5 1161.9 20689.4 21107.6 21327.1 21373.6 21447.1 1026.3 1061.5 1083.7 1101.3 1131.1 11127.5 12023.2 12106.6 12187.9 12248.8 368010.0 372530.0 375138.0 476038.0 483448.0 74690.6 98716.0 101938.0 102820.0 105381.0 1004.6 1008.6 1037.4 1043.2 1058.2 18632.9 18821.7 19590.5 19597.3 19672.7 32211.0 37340.0 42778.6 45157.5 45772.0 63437.7 63483.0 63864.7 64248.4 66168.0 8401.7 8684.3 8907.8 8972.8 9161.6 12738.9 13568.4 13630.7 13661.0 13903.4 12017.7 12044.9 12133.3 12165.8 12275.5 11676.4 11699.9 11709.4 11795.3 12008.5 11841.0 12019.3 12211.9 12335.0 12614.1 8664.4 8751.7 8801.5 8860.0 8883.4 9462.5 10881.2 11079.5 11173.1 11407.5 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | [#3] mootools.html Cycles:180 Average:5769.51 Median:4889.24 stddev:3278.34 (67.1%) stddev-sans-first:3270.85 05:33:48 INFO - PROCESS | 28444 | Values: 1367.2 1473.9 1517.9 1576.2 1734.0 8339.5 8701.4 8804.6 9160.3 9160.8 8949.2 9039.4 9047.3 9049.7 9052.5 2351.3 2390.7 2392.8 2395.3 2395.7 2349.2 2378.0 2406.3 2412.8 2416.2 2351.5 2375.7 2383.4 2385.8 2389.8 2243.1 2282.7 2288.7 2289.9 2343.2 2286.2 2310.6 2310.8 2314.7 2317.1 7723.3 8923.9 9054.8 9121.1 9168.1 5080.7 5258.4 5286.8 5371.5 5381.1 3468.6 3491.0 3543.5 3550.0 3569.8 1228.7 1230.6 1230.9 1247.3 1255.8 12661.4 12676.0 12686.9 12693.8 12704.0 4427.5 4678.6 4736.1 4850.3 4852.9 10532.7 10538.5 10543.9 10546.0 10550.3 5361.8 5365.8 5367.4 5369.2 5373.5 4826.6 4925.6 4930.1 4933.7 4941.4 3855.7 3910.2 3977.8 4012.0 4012.6 1200.6 1200.8 1202.8 1217.9 1228.3 937.3 961.7 969.3 976.6 992.0 5700.6 5761.7 5811.7 5834.3 5936.9 460.7 463.5 465.3 469.3 483.0 3913.1 3946.2 3972.0 4047.0 4138.2 10076.1 10174.7 10282.5 10408.9 10889.6 10516.4 10625.2 10628.6 10630.0 10638.6 8078.6 8167.7 8210.4 8218.2 8234.9 5971.9 6006.8 6026.3 6028.4 6193.8 9351.2 9659.0 9674.6 9718.0 9777.9 10107.4 10110.2 10119.8 10125.3 10143.2 7358.7 7374.2 7385.9 7391.2 7443.5 8302.2 8393.5 8398.5 8471.8 8482.1 7588.8 7610.5 7671.6 7685.6 7787.1 7343.5 7421.4 7456.0 7504.1 7557.3 6632.4 6689.6 6696.2 6712.3 6766.1 5224.2 5251.4 5290.4 5378.4 5380.9 5069.6 5090.2 5269.9 5282.6 5301.6 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | [#4] prototype.html Cycles:180 Average:4429.02 Median:4944.70 stddev:1268.43 (25.7%) stddev-sans-first:1233.76 05:33:48 INFO - PROCESS | 28444 | Values: 311.7 326.1 330.1 331.1 333.3 5220.5 5226.9 5255.0 5266.8 5267.7 4887.6 4977.4 5151.1 5164.8 5177.4 4114.5 4119.4 4121.1 4142.9 4146.6 4120.6 4130.6 4142.7 4147.3 4155.1 3910.2 3923.9 4077.4 4077.6 4091.3 4083.5 4090.0 4101.9 4104.9 4112.4 3655.7 3658.4 3661.5 3661.9 3683.7 5009.9 5052.7 5074.7 5150.2 5150.8 4670.7 4677.8 4699.0 4722.2 4730.0 5361.2 5381.5 5397.3 5427.6 5457.3 3746.8 3927.7 4019.3 4027.4 4030.9 5612.3 5621.7 5624.2 5628.5 5647.0 4027.0 4041.3 4043.3 4045.2 4049.0 3857.5 4113.7 4116.4 4122.2 4133.4 4550.2 4581.8 4582.3 4626.6 4631.7 5382.6 5398.6 5403.5 5464.7 5468.2 1365.0 1385.3 1397.4 1399.0 1409.6 901.2 916.2 920.9 926.7 941.3 4719.3 4729.0 4787.5 4787.5 4804.6 4949.9 4966.3 4974.5 4982.2 4983.8 4483.3 4627.4 4652.3 4668.3 4680.0 2637.6 2641.4 2644.4 2648.0 2657.3 5132.6 5162.7 5176.4 5196.2 5216.6 4869.3 4898.6 4961.3 5042.4 5045.6 5093.5 5131.4 5139.4 5153.4 5175.8 4848.5 4922.0 4939.5 4977.7 4981.0 4569.0 4824.0 4836.6 4847.0 4848.9 5097.2 5118.2 5122.2 5162.4 5220.3 3721.4 3732.2 3742.1 3743.2 3751.2 5059.8 5186.7 5578.9 5611.5 5617.8 5470.7 5471.8 5487.7 5489.2 5491.8 5212.3 5475.1 5483.8 5542.9 5560.3 5403.5 5405.5 5432.8 5433.9 5448.3 5490.1 5506.3 5521.7 5555.9 5563.7 5164.2 5368.4 5395.5 5419.9 5436.6 05:33:48 INFO - PROCESS | 28444 | 05:33:48 INFO - PROCESS | 28444 | [#5] yui.html Cycles:180 Average:20779.48 Median:4381.18 stddev:29831.94 (680.9%) stddev-sans-first:29877.64 05:33:48 INFO - PROCESS | 28444 | Values: 731.0 738.9 761.4 770.3 810.6 15301.8 16129.4 16292.0 16293.6 16342.3 14772.7 14879.3 14887.8 14921.8 14972.4 658.3 776.1 782.3 796.4 798.6 797.6 807.6 814.2 814.7 815.0 865.0 867.4 867.9 868.3 868.5 692.7 837.8 864.8 865.2 865.4 624.1 629.4 629.6 632.6 634.1 14843.7 14877.9 14924.5 14984.8 15021.1 15464.1 15674.6 15682.7 15834.7 16015.8 12635.5 12676.7 12690.2 12743.2 12883.7 3896.9 3978.3 4021.4 4044.0 4175.9 67495.3 68299.3 69530.3 83247.0 83487.2 11434.3 11796.1 11907.2 11989.7 12177.0 21873.2 22035.6 22127.3 22144.1 22245.6 8519.0 8608.1 8790.5 8924.8 8945.0 4765.2 4831.5 4838.0 4898.8 5002.1 3397.5 3502.3 3507.9 3513.3 3520.1 587.4 594.6 599.4 600.3 609.7 678.6 708.9 710.4 712.7 716.5 9297.0 9533.8 9621.3 9822.3 10027.7 664.0 692.7 699.1 722.6 726.8 4368.6 4393.8 4584.5 4670.3 4671.2 70138.6 72208.6 94857.5 127994.0 130483.7 106690.2 107664.0 108003.5 109794.5 112910.4 59151.4 80914.6 96804.5 99137.0 101045.0 9481.4 9664.6 9814.9 9834.8 10122.0 54412.0 54951.0 56707.4 56892.0 57947.4 47704.0 70014.6 77078.0 77183.6 79162.0 12061.3 12099.8 12104.2 12224.8 12612.9 15302.3 15345.7 15408.5 15491.9 15608.8 12748.3 13724.4 14074.4 14604.3 14639.3 14126.7 14470.2 14561.6 14713.8 14740.2 12321.4 12402.4 12409.4 12871.5 13025.3 11408.0 11453.2 11484.2 11617.4 11876.5 10581.5 11252.9 11327.3 11441.5 11887.3 05:33:48 INFO - PROCESS | 28444 | -------- Summary: end -------- 05:33:48 INFO - PROCESS | 28444 | 05:33:49 INFO - TEST-INFO | 28444: exit 0 05:33:49 INFO - TEST-OK | dromaeo_css | took 1115067ms 05:33:49 INFO - TEST-START | kraken 05:33:49 INFO - operating with platform_type : linux_ 05:33:49 INFO - Initialising browser for kraken test... 05:33:49 INFO - TEST-INFO | started process 28637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbjV1Pn/profile http://localhost:33846/getInfo.html) 05:33:53 INFO - PROCESS | 28637 | __metrics Screen width/height:1600/1200 05:33:53 INFO - PROCESS | 28637 | colorDepth:24 05:33:53 INFO - PROCESS | 28637 | Browser inner width/height: 1024/697 05:33:53 INFO - PROCESS | 28637 | __metrics 05:33:53 INFO - PROCESS | 28637 | 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" 05:33:53 INFO - PROCESS | 28637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:54 INFO - TEST-INFO | 28637: exit 0 05:33:54 INFO - Browser initialized. 05:33:54 INFO - Running cycle 1/1 for kraken test... 05:33:54 INFO - TEST-INFO | started process 28720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbjV1Pn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:06 INFO - PROCESS | 28720 | RSS: Main: 156540928 05:34:06 INFO - PROCESS | 28720 | 05:34:09 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33846/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:10 INFO - PROCESS | 28720 | RSS: Main: 212570112 05:34:10 INFO - PROCESS | 28720 | 05:34:12 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33846/tests/kraken/driver.html?testName=audio-dft) 05:34:13 INFO - PROCESS | 28720 | RSS: Main: 192806912 05:34:13 INFO - PROCESS | 28720 | 05:34:16 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33846/tests/kraken/driver.html?testName=audio-fft) 05:34:17 INFO - PROCESS | 28720 | RSS: Main: 269684736 05:34:17 INFO - PROCESS | 28720 | 05:34:19 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33846/tests/kraken/driver.html?testName=audio-oscillator) 05:34:19 INFO - PROCESS | 28720 | RSS: Main: 179593216 05:34:19 INFO - PROCESS | 28720 | 05:34:21 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33846/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:22 INFO - PROCESS | 28720 | RSS: Main: 184180736 05:34:22 INFO - PROCESS | 28720 | 05:34:25 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33846/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:26 INFO - PROCESS | 28720 | RSS: Main: 219205632 05:34:26 INFO - PROCESS | 28720 | 05:34:29 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33846/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:30 INFO - PROCESS | 28720 | RSS: Main: 219553792 05:34:30 INFO - PROCESS | 28720 | 05:34:32 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33846/tests/kraken/driver.html?testName=json-parse-financial) 05:34:33 INFO - PROCESS | 28720 | RSS: Main: 219607040 05:34:33 INFO - PROCESS | 28720 | 05:34:34 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33846/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:35 INFO - PROCESS | 28720 | RSS: Main: 184303616 05:34:35 INFO - PROCESS | 28720 | 05:34:37 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:37 INFO - PROCESS | 28720 | RSS: Main: 190451712 05:34:37 INFO - PROCESS | 28720 | 05:34:39 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:40 INFO - PROCESS | 28720 | RSS: Main: 194686976 05:34:40 INFO - PROCESS | 28720 | 05:34:43 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:43 INFO - PROCESS | 28720 | RSS: Main: 188604416 05:34:43 INFO - PROCESS | 28720 | 05:34:46 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:46 INFO - PROCESS | 28720 | RSS: Main: 192987136 05:34:46 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | Cycle 1(1): loaded http://localhost:33846/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33846/tests/kraken/driver.html?testName=ai-astar) 05:34:48 INFO - PROCESS | 28720 | RSS: Main: 243556352 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | __start_tp_report 05:34:48 INFO - PROCESS | 28720 | _x_x_mozilla_page_load 05:34:48 INFO - PROCESS | 28720 | _x_x_mozilla_page_load_details 05:34:48 INFO - PROCESS | 28720 | |i|pagename|runs| 05:34:48 INFO - PROCESS | 28720 | |0;ai-astar;101;112;109;110;111;112;112;111;114;110 05:34:48 INFO - PROCESS | 28720 | |1;audio-beat-detection;146;116;123;172;117;120;147;116;151;118 05:34:48 INFO - PROCESS | 28720 | |2;audio-dft;161;161;160;161;162;162;171;164;165;163 05:34:48 INFO - PROCESS | 28720 | |3;audio-fft;74;76;75;110;75;75;74;75;99;75 05:34:48 INFO - PROCESS | 28720 | |4;audio-oscillator;84;83;129;84;85;85;117;86;84;135 05:34:48 INFO - PROCESS | 28720 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;117;117;117 05:34:48 INFO - PROCESS | 28720 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 05:34:48 INFO - PROCESS | 28720 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 05:34:48 INFO - PROCESS | 28720 | |8;json-parse-financial;52;52;49;50;50;50;50;52;49;50 05:34:48 INFO - PROCESS | 28720 | |9;json-stringify-tinderbox;59;60;60;59;59;59;59;59;60;59 05:34:48 INFO - PROCESS | 28720 | |10;stanford-crypto-aes;75;75;76;75;84;79;76;76;75;74 05:34:48 INFO - PROCESS | 28720 | |11;stanford-crypto-ccm;124;122;129;129;118;124;122;120;138;130 05:34:48 INFO - PROCESS | 28720 | |12;stanford-crypto-pbkdf2;159;156;158;159;161;158;157;157;158;159 05:34:48 INFO - PROCESS | 28720 | |13;stanford-crypto-sha256-iterative;66;63;62;63;62;62;62;69;62;64 05:34:48 INFO - PROCESS | 28720 | __end_tp_report 05:34:48 INFO - PROCESS | 28720 | __start_cc_report 05:34:48 INFO - PROCESS | 28720 | _x_x_mozilla_cycle_collect,1672 05:34:48 INFO - PROCESS | 28720 | __end_cc_report 05:34:48 INFO - PROCESS | 28720 | __startTimestamp1470746088872__endTimestamp 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | ------- Summary: start ------- 05:34:48 INFO - PROCESS | 28720 | Number of tests: 14 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.52 (3.2%) stddev-sans-first:1.48 05:34:48 INFO - PROCESS | 28720 | Values: 101.0 112.0 109.0 110.0 111.0 112.0 112.0 111.0 114.0 110.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:134.50 stddev:19.82 (14.7%) stddev-sans-first:20.42 05:34:48 INFO - PROCESS | 28720 | Values: 146.0 116.0 123.0 172.0 117.0 120.0 147.0 116.0 151.0 118.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:3.20 (2.0%) stddev-sans-first:3.31 05:34:48 INFO - PROCESS | 28720 | Values: 161.0 161.0 160.0 161.0 162.0 162.0 171.0 164.0 165.0 163.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.77 (17.0%) stddev-sans-first:13.31 05:34:48 INFO - PROCESS | 28720 | Values: 74.0 76.0 75.0 110.0 75.0 75.0 74.0 75.0 99.0 75.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:84.00 stddev:21.03 (25.0%) stddev-sans-first:21.75 05:34:48 INFO - PROCESS | 28720 | Values: 84.0 83.0 129.0 84.0 85.0 85.0 117.0 86.0 84.0 135.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:34:48 INFO - PROCESS | 28720 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:34:48 INFO - PROCESS | 28720 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:34:48 INFO - PROCESS | 28720 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.00 stddev:1.17 (2.3%) stddev-sans-first:1.09 05:34:48 INFO - PROCESS | 28720 | Values: 52.0 52.0 49.0 50.0 50.0 50.0 50.0 52.0 49.0 50.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 05:34:48 INFO - PROCESS | 28720 | Values: 59.0 60.0 60.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:2.95 (3.9%) stddev-sans-first:3.08 05:34:48 INFO - PROCESS | 28720 | Values: 75.0 75.0 76.0 75.0 84.0 79.0 76.0 76.0 75.0 74.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:126.50 stddev:5.93 (4.7%) stddev-sans-first:6.26 05:34:48 INFO - PROCESS | 28720 | Values: 124.0 122.0 129.0 129.0 118.0 124.0 122.0 120.0 138.0 130.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.50 stddev:1.40 (0.9%) stddev-sans-first:1.45 05:34:48 INFO - PROCESS | 28720 | Values: 159.0 156.0 158.0 159.0 161.0 158.0 157.0 157.0 158.0 159.0 05:34:48 INFO - PROCESS | 28720 | 05:34:48 INFO - PROCESS | 28720 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.32 (3.7%) stddev-sans-first:2.28 05:34:48 INFO - PROCESS | 28720 | Values: 66.0 63.0 62.0 63.0 62.0 62.0 62.0 69.0 62.0 64.0 05:34:48 INFO - PROCESS | 28720 | -------- Summary: end -------- 05:34:48 INFO - PROCESS | 28720 | 05:34:49 INFO - TEST-INFO | 28720: exit 0 05:34:49 INFO - TEST-OK | kraken | took 60837ms 05:34:49 INFO - SUITE-END | took 1175s 05:34:50 INFO - Completed test suite (00:19:36) 05:34:50 INFO - javascript benchmark 05:34:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.592490013848, 3033.120395085425, 3046.238440389901, 3046.4364092642854, 3051.908442746717, 5189.351331083614, 5247.553957913582, 5287.101192797224, 5346.652467589604, 5383.62314637975, 5289.947100528993, 5327.041132596131, 5370.113931201347, 5390.460953904608, 5449.754761035753, 4794.0, 4800.855974320776, 4820.445648750386, 4833.250846118857, 4991.550760431561, 4911.410630724318, 4936.185529387647, 4940.481249468808, 4949.109160351135, 4955.182394904837, 4717.410323709536, 4769.546893045155, 4778.139934811733, 4865.099956508057, 4865.708057516543, 4808.735519546423, 4818.903621927542, 4820.758962051884, 4822.807087716487, 4837.250226214907, 4736.9526304736855, 4782.378290822171, 4794.736289504076, 4794.95205047952, 4824.421069471651, 5221.347331583552, 5272.499112584298, 5273.2617433559335, 5349.491798279158, 5371.838844834661, 5717.285339332583, 5724.112762521774, 5729.312482502127, 5766.596338256324, 5767.452092051249, 5439.3200849893765, 5700.087985922232, 5733.369329373765, 5751.827445176609, 5789.16057171712, 5366.570674346043, 5389.757460914268, 5393.8112166074, 5406.432324605899, 5406.486383793534, 5916.645001299936, 5929.881402371929, 5931.288245410492, 5933.465988061009, 5937.465628093492, 5332.360116785933, 5454.154606036071, 5467.1799230115, 5520.558355331564, 5674.290713660793, 5606.411326810708, 5644.604877658525, 5645.971770141123, 5653.491185793298, 5662.773489060474, 5590.273264475592, 5592.636478628876, 5593.804216852472, 5595.160725891149, 5600.047991841397, 5490.450954904478, 5586.329640443173, 5613.045782217033, 5613.214150019001, 5650.378458369576, 4302.376155457441, 4307.504636966726, 4307.978460107742, 4345.0, 4352.847650332224, 3799.4110912808005, 3815.751976121543, 3827.138893748884, 3849.172427927953, 3861.1698484825897, 5159.097157997336, 5331.733413329318, 5372.1941708744, 5389.02997460453, 5442.2380866678695, 5779.306483222041, 5795.536357091422, 5805.187273781674, 5817.156512305692, 5857.47282744555, 5408.161734931092, 5428.864278393072, 5443.292371991695, 5445.53712934405, 5446.346438427414, 4737.0, 4785.641076919245, 4934.259861020875, 4942.20924652054, 4996.90006199874, 5791.0, 5883.735231914488, 5903.675297858659, 5919.970400148058, 5944.019236825961, 5645.548356131418, 5657.519110875457, 5659.26429564154, 5663.122216056518, 5665.320161580472, 5756.136579513107, 5858.414158584107, 5862.384449632727, 5868.589198756046, 5893.734781934909, 5593.4126916674795, 5627.718614069362, 5635.323761148688, 5675.517581005495, 5686.886262274814, 5711.057675483665, 5748.511376532874, 5761.251037365116, 5767.625104368202, 5767.826965191051, 5432.674039557481, 5538.889222215453, 5569.220309156803, 5617.747201375866, 5617.8033768817895, 5559.0, 5577.107662773937, 5590.552755779447, 5618.073017951992, 5647.20939068539, 5518.33779946409, 5520.06158952971, 5527.281453411031, 5531.419200983839, 5534.7786088556, 5452.018636645442, 5551.167324901297, 5669.34802497718, 5690.715464226855, 5693.943060569507, 5424.566034717134, 5499.0, 5501.119820828648, 5538.556915446674, 5547.195656629686], "value": 5243.782519828605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6177303865967, 601.2634522709682, 608.7352001879183, 613.4908026338138, 616.8457885528618, 42804.78597607012, 43841.561584384144, 43845.56154438459, 43853.56146438535, 47670.76164619172, 45062.54937450625, 45403.77298113505, 45473.31790023152, 45518.0, 45632.771836140855, 8877.86683199751, 9037.051109633492, 9040.954795226015, 9047.683331083414, 9052.41159324645, 8948.463092214488, 9015.95492022539, 9046.502442365667, 9048.592813323416, 9049.95475022624, 9118.13377729118, 9137.451752894847, 9160.129787670161, 9160.816783664355, 9168.129027742387, 9050.366474346798, 9090.681826136053, 9091.31815113869, 9092.8636070459, 9093.0, 8904.643814247422, 9032.593533291018, 9034.32242581809, 9044.728658140266, 9047.773805654846, 41425.79287103545, 41961.37057944103, 41963.7901810489, 42060.158796824195, 42064.78967605143, 3600.6219346968455, 4004.6796256299426, 4192.748435093874, 4328.480582330109, 4444.866654000385, 32866.849660261774, 33346.83326583376, 33374.666253337644, 33508.83245583781, 33845.6615433845, 4266.87199384019, 4399.340098985146, 4406.449193850769, 4536.4102666653125, 4540.682152249344, 248986.0, 249650.75174624193, 253905.0, 254456.0, 256879.0, 54846.0, 54923.72538137284, 54960.17559736607, 55305.723471382385, 55414.0, 58373.0, 58630.413695862495, 58669.70665146647, 58736.412635873094, 58812.7059364709, 14221.28893555318, 14263.85736142646, 14316.0, 14348.928255358865, 14359.210243436712, 12062.577809776616, 12134.453949572291, 12162.08784341178, 12163.331016793984, 12164.0, 12436.258923750682, 15816.130112843904, 15816.446424375321, 15864.0, 16144.75782863258, 5379.65032272901, 6243.562950593415, 6502.219733631994, 6534.967325163344, 6701.731930722814, 1026.2918586175515, 1057.5346847387125, 1086.6414083352474, 1088.2545456362418, 1125.7973564758258, 31242.21894452657, 32510.0, 33089.3382132356, 33217.0, 33658.831705841316, 1128.1595211567435, 1132.7621199548023, 1143.7369405036889, 1152.1589239854952, 1195.0678470792795, 16875.746863797052, 17400.21699023547, 17414.564635884206, 17421.738673919903, 17591.96524650274, 514921.0, 515256.0, 515599.0, 515795.0, 520984.0, 55428.72285638546, 55637.44362556404, 55653.165202521996, 55730.0, 55784.16323755147, 1232.4084439469104, 1323.8146659467682, 1358.8505264420905, 1370.9931450342685, 1381.6753063029978, 32514.349713005133, 33752.0, 34319.4852077214, 34385.82807086049, 34463.65536344604, 49583.25625115554, 49975.0, 50163.0, 50228.0, 50265.49734502608, 404814.0, 406841.0, 407165.0, 407226.0, 409365.0, 27777.861110694317, 27926.44147117087, 28290.0, 28605.570916435852, 41842.79078604587, 43969.0, 44070.0, 47279.29081063856, 47401.0, 48077.27884081672, 38447.80776096102, 39765.80117099512, 40420.716016689206, 40502.1899562013, 41678.583214168684, 39924.20151596894, 40661.390079148245, 40743.388849166695, 41949.58050419579, 42360.36459453049, 40182.39726404165, 41044.38433423441, 41491.0, 41607.0, 42264.0, 34770.478442823885, 36503.45244821277, 36853.54366735097, 36917.63082369142, 37176.81411592925, 27980.30049248785, 28220.730067147437, 28379.716202837706, 28507.28731781722, 28593.28516787097], "value": 19803.011644508224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.9406494960807, 378.9374753165728, 386.88780253726424, 393.82671624485226, 418.6253303293552, 17323.653526929455, 19659.606807863853, 19737.901310493427, 19913.103910324033, 20735.896320518415, 19843.0, 20066.197352105934, 20078.59842803143, 20264.0, 20581.27965521207, 5214.791408343662, 5731.713414329288, 5872.236609240793, 5916.467517923386, 5940.0, 5728.68492232927, 5770.509506691937, 5802.738876750535, 5815.651060936336, 5818.621789583684, 5638.210650508911, 5773.826785196451, 5845.152452894349, 5867.354590994987, 5869.295684517842, 5664.631798933056, 5866.5306775458075, 5905.645661260295, 5911.704414779244, 5915.674637894914, 5215.582753379758, 5248.763805628756, 5254.92117618236, 5255.264263003182, 5257.764425360037, 24583.63124553133, 24630.0, 24908.626370604274, 24949.126780562776, 24980.250592482254, 2370.111208296889, 2467.6668649732414, 3058.6023816903885, 3178.586783718125, 3195.3769015042076, 14505.202213878232, 15024.17367044812, 15031.098134111879, 15255.0, 15466.61333466661, 1889.0, 1912.3880358285355, 1963.980360196394, 2025.1595587831032, 2057.5164836263466, 66642.66678666625, 81431.0, 83810.0, 84043.0, 86112.81928216873, 10850.728731781768, 11027.117830573536, 11268.943655281671, 11398.943005285086, 11426.0, 15445.382184712485, 15457.072575645498, 15474.148921809183, 15491.612709682347, 15500.30248638814, 7403.148637906602, 7456.664450099758, 7884.053913530298, 7903.446758726949, 8031.196880311922, 6941.757038503628, 7541.057367829021, 7849.979502664617, 8049.718259860877, 8106.432549721463, 6772.153480814898, 6876.724931002704, 6903.1371078615175, 6904.758333458305, 6929.653517324114, 1956.7162761399802, 1974.4767636576319, 1994.3917105282737, 2015.981929125782, 2023.352527191314, 909.6997990663066, 948.0756262643868, 1001.9398836069859, 1073.5169173871789, 1161.872194058653, 20689.379318620464, 21107.577848442947, 21327.146914123572, 21373.552972025205, 21447.14211431525, 1026.3328836256344, 1061.5170097605571, 1083.685731137961, 1101.251149218539, 1131.134681968295, 11127.499262533205, 12023.21849079807, 12106.576269830513, 12187.939060304641, 12248.755024899452, 368010.0, 372530.0, 375138.0, 476038.0, 483448.0, 74690.62654686692, 98716.0, 101938.0, 102820.0, 105381.0, 1004.5579944824254, 1008.6318493749728, 1037.3775734559356, 1043.2280112716535, 1058.216919479595, 18632.906835465736, 18821.717674234624, 19590.510237243612, 19597.31409400664, 19672.704909426655, 32211.033668989967, 37340.0, 42778.57221427746, 45157.548424515335, 45772.0, 63437.682811587496, 63483.0, 63864.68067659632, 64248.357516426106, 66168.0, 8401.70594029206, 8684.261837743863, 8907.821843562962, 8972.820543589221, 9161.587728552098, 12738.936305318413, 13568.38942247621, 13630.727385452037, 13661.0, 13903.374348154559, 12017.699557511132, 12044.879551204725, 12133.272003679807, 12165.75668486643, 12275.508979641072, 11676.416179191176, 11699.88300116988, 11709.365392786554, 11795.29228246308, 12008.459619316976, 11841.0, 12019.278843269432, 12211.877881221075, 12335.0, 12614.053945953907, 8664.436811607226, 8751.693690720795, 8801.515916624647, 8860.006498538036, 8883.42257753244, 9462.479563624067, 10881.183911206534, 11079.501422436171, 11173.05029072538, 11407.486663100346], "value": 9620.440087136842, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.248013592525, 1473.9336729847155, 1517.9165145916973, 1576.2118940529735, 1734.028943791476, 8339.457935234213, 8701.434406763556, 8804.647814087444, 9160.26717862571, 9160.816783664322, 8949.194572488475, 9039.412438191514, 9047.321450891193, 9049.683261085864, 9052.45685258885, 2351.329870986769, 2390.725066617335, 2392.7966122879575, 2395.317334559651, 2395.6765836612094, 2349.1543044503965, 2377.988110059447, 2406.302172370011, 2412.7707867752533, 2416.1664225842055, 2351.49442869783, 2375.7386687464364, 2383.4279772854475, 2385.7733515316017, 2389.844660097097, 2243.1139699818646, 2282.669012993115, 2288.656701494781, 2289.8740569268766, 2343.1798870395223, 2286.216750934274, 2310.572544079351, 2310.849794763335, 2314.6990891184037, 2317.084751523139, 7723.343515801163, 8923.910760892373, 9054.818903621957, 9121.087891210826, 9168.129027742354, 5080.74596270185, 5258.447862974371, 5286.762095705664, 5371.462853714636, 5381.13901775714, 3468.601110872257, 3491.0, 3543.450765131409, 3550.041488798036, 3569.821508924543, 1228.6928267933017, 1230.593904011683, 1230.9015278777676, 1247.2516490105954, 1255.8367412236441, 12661.36693165338, 12676.049296302814, 12686.873131268754, 12693.809592856114, 12704.04719646021, 4427.468703755506, 4678.649101317346, 4736.123817093849, 4850.296706977469, 4852.902941941142, 10532.684019479428, 10538.525766340534, 10543.94728026355, 10546.0, 10550.261481696207, 5361.785528578813, 5365.839024829262, 5367.355917289872, 5369.24830523727, 5373.489518495737, 4826.58973987215, 4925.581325587294, 4930.063287975273, 4933.654644174873, 4941.382327209099, 3855.7108216883285, 3910.178862438863, 3977.8209980550946, 4012.0371110933165, 4012.578679238696, 1200.6158029430674, 1200.8018676918384, 1202.837616921722, 1217.9391030448442, 1228.3489750432286, 937.3485427627734, 961.7451375385529, 969.2682025071026, 976.5995941663883, 991.9603215871284, 5700.572457065737, 5761.740721667535, 5811.680357580373, 5834.27071616048, 5936.940630593639, 460.7419844886874, 463.48321621391904, 465.3206318774627, 469.3312030356728, 482.995170048295, 3913.1391093959282, 3946.1515774108702, 3971.980140099281, 4046.9797651012145, 4138.172365526907, 10076.143527800219, 10174.745631359276, 10282.485875706185, 10408.907064758243, 10889.564417423215, 10516.3690178588, 10625.203109766799, 10628.627998020032, 10630.043296103388, 10638.627648032281, 8078.555679437687, 8167.714130005421, 8210.384221183434, 8218.178182181735, 8234.876476852853, 5971.940280597139, 6006.819795406145, 6026.276846778414, 6028.367021462684, 6193.752249909953, 9351.205147562534, 9659.034096590285, 9674.564644591152, 9717.951410242904, 9777.9022209777, 10107.444090575089, 10110.241731870286, 10119.848202277119, 10125.291229613857, 10143.239257055602, 7358.742444014434, 7374.225706300976, 7385.9261407387385, 7391.186969433251, 7443.4789564729945, 8302.169783021649, 8393.454425462325, 8398.454100483448, 8471.788205294917, 8482.109378515168, 7588.8482230353975, 7610.505317154367, 7671.578063206354, 7685.615719214129, 7787.10448298453, 7343.522671026366, 7421.443391745533, 7456.0, 7504.099508059068, 7557.2820582044615, 6632.403083722488, 6689.598624082376, 6696.1629796275465, 6712.2616512184595, 6766.086578311865, 5224.242484839753, 5251.448597897319, 5290.365156181283, 5378.40837507866, 5380.865478363072, 5069.6197785167, 5090.2364645303505, 5269.947300526946, 5282.6038047147385, 5301.628885977944], "value": 4558.101803548247, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.68519795007035, 326.091834241637, 330.118583382369, 331.10931594012123, 333.2934179539377, 5220.530152286294, 5226.8693282667855, 5254.973725131369, 5266.789328426863, 5267.710275934832, 4887.608991280698, 4977.427595826481, 5151.072806894757, 5164.845054648357, 5177.378714554259, 4114.506259248879, 4119.40268661044, 4121.113960498492, 4142.896427589304, 4146.6268035876765, 4120.6195924365375, 4130.566290539495, 4142.653637567802, 4147.336426171813, 4155.148194620096, 3910.178862438877, 3923.9215215695667, 4077.368007958756, 4077.5922407759285, 4091.3453847384426, 4083.509978802533, 4089.9795501022454, 4101.85643502476, 4104.91790164195, 4112.437273835923, 3655.7204978257664, 3658.414653655429, 3661.5423072115987, 3661.8718344857803, 3683.723720720957, 5009.874753131201, 5052.671576347562, 5074.720890351029, 5150.227465880111, 5150.845474635729, 4670.743109128996, 4677.812887484531, 4698.976505117486, 4722.220833562493, 4729.9763501182615, 5361.2226227197225, 5381.5425688816495, 5397.325334333208, 5427.592930530226, 5457.263269458612, 3746.812659367048, 3927.7054220933546, 4019.336809426441, 4027.35562310029, 4030.9193816123807, 5612.270404847343, 5621.7189140542805, 5624.184493248497, 5628.465295796934, 5647.0, 4026.9999999999413, 4041.2725709372594, 4043.272211001989, 4045.1707399982934, 4048.959510404858, 3857.4599556062176, 4113.71204015716, 4116.403121547359, 4122.175564887035, 4133.379993001074, 4550.2492088804975, 4581.839635612738, 4582.28974508945, 4626.606738427204, 4631.745254011062, 5382.596305277119, 5398.568114550826, 5403.459654034565, 5464.726763661881, 5468.207109969032, 1364.986350136486, 1385.2658091211674, 1397.4410235905718, 1399.0, 1409.5559898631898, 901.1799262670938, 916.1525588830306, 920.8857282687889, 926.7173512078881, 941.275218082073, 4719.339292499053, 4728.976355118202, 4787.497312782178, 4787.497312782178, 4804.639652026042, 4949.90100197994, 4966.329545511382, 4974.527419895104, 4982.202847544448, 4983.825566105169, 4483.349914262414, 4627.3521706961055, 4652.302154676758, 4668.253079507263, 4680.040591678766, 2637.5648018076804, 2641.4056837211856, 2644.3917898883365, 2647.9805274969276, 2657.2958166086005, 5132.56373208274, 5162.6902385856965, 5176.404713457925, 5196.194589838581, 5216.556592689588, 4869.342638743724, 4898.632602554822, 4961.320886721202, 5042.369703787027, 5045.587235574045, 5093.541581257705, 5131.384233891957, 5139.383274007068, 5153.381594208644, 5175.792968281226, 4848.490908454703, 4921.950780492292, 4939.50554969738, 4977.676451030671, 4981.0, 4568.954310456853, 4824.0, 4836.637252206169, 4846.95153048465, 4848.903021939612, 5097.1844504879045, 5118.155504341891, 5122.231665250242, 5162.354705661793, 5220.269162317354, 3721.404575267944, 3732.2348918471107, 3742.1393079591303, 3743.213925075656, 3751.15598990225, 5059.772310246121, 5186.740662966912, 5578.888422231614, 5611.466910643482, 5617.8033768817895, 5470.671759694431, 5471.835844924659, 5487.670739755627, 5489.204065410573, 5491.75287112073, 5212.348456442945, 5475.09660905946, 5483.835484935458, 5542.944570554404, 5560.304961879765, 5403.459654034565, 5405.5135037846785, 5432.821799247485, 5433.9184912225555, 5448.338256831546, 5490.066688663017, 5506.339239291311, 5521.668699878021, 5555.944440555542, 5563.693996830213, 5164.1995490699, 5368.436314186954, 5395.514403703685, 5419.918701219563, 5436.619436639556], "value": 4028.8559047865283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.9524880882742, 738.8743913534698, 761.4213197969541, 770.2643975003872, 810.5744484145823, 15301.846981530181, 16129.354825806982, 16291.999999999985, 16293.59266018347, 16342.264598093085, 14772.704545909075, 14879.256037198124, 14887.776683349759, 14921.776173357408, 14972.401103955828, 658.3317932298721, 776.0919723922996, 782.295933659708, 796.366888323781, 798.6286376834771, 797.5533701127388, 807.588130053671, 814.1736137820118, 814.7392834293029, 814.9592520373958, 864.9654013839439, 867.4014929698519, 867.8828358171661, 868.2836659755695, 868.4658934755143, 692.6813665713778, 837.7528629054383, 864.7794812322849, 865.212656482601, 865.4028720183054, 624.0888303077512, 629.351767679291, 629.5561629051508, 632.5508888689036, 634.1249076274711, 14843.703125937422, 14877.925610371987, 14924.477643282542, 14984.82720005593, 15021.098734075882, 15464.149471779048, 15674.608134796606, 15682.68634627301, 15834.683306333924, 16015.759763603555, 12635.494580216871, 12676.746465070739, 12690.175138615961, 12743.235405875677, 12883.67790805228, 3896.8636097736726, 3978.3236849735613, 4021.396790481422, 4044.0, 4175.853845115406, 67495.32504674939, 68299.31700683029, 69530.3046969529, 83247.0, 83487.16512834854, 11434.256773309708, 11796.115291353182, 11907.226030308175, 11989.700257493458, 12177.0, 21873.234436794955, 22035.567688100222, 22127.33617991463, 22144.114235430723, 22245.55508889813, 8519.0, 8608.09614990417, 8790.516521591373, 8924.821503569892, 8945.0, 4765.213739732905, 4831.4685384607665, 4837.975810120997, 4898.779554920037, 5002.074616196015, 3397.473391624302, 3502.264524449843, 3507.94738078929, 3513.297340531904, 3520.1375662962737, 587.4155215560545, 594.6224147666263, 599.3946114424375, 600.342624825815, 609.6585911889267, 678.555546117284, 708.929107089287, 710.4139085254685, 712.7434123715458, 716.4984510842327, 9297.0, 9533.761655958657, 9621.326507144433, 9822.312438129406, 10027.749306267257, 663.9966800165968, 692.6882902693808, 699.1016543741268, 722.5592388642924, 726.8255618651591, 4368.584984426474, 4393.780310984438, 4584.541545845455, 4670.346151538719, 4671.15919134559, 70138.64930675416, 72208.63895680488, 94857.525712371, 127994.0, 130483.69516304716, 106690.19717633934, 107664.0, 108003.45998269958, 109794.45102774595, 112910.43544782224, 59151.408485915454, 80914.59542702249, 96804.51597741967, 99137.0, 101045.0, 9481.383710058824, 9664.565094570902, 9814.889798693315, 9834.803303933739, 10122.0, 54412.0, 54950.9999999984, 56707.43292567186, 56892.0, 57947.4205257942, 47704.0, 70014.64992675003, 77078.0, 77183.61408193148, 79162.0, 12061.276323420623, 12099.81850272229, 12104.213226140273, 12224.75550489003, 12612.87387126117, 15302.311395986984, 15345.693086137991, 15408.537743867702, 15491.922540387226, 15608.765868511755, 12748.298843563693, 13724.382402791698, 14074.366653500412, 14604.342804574033, 14639.268036597914, 14126.717465650834, 14470.20413877247, 14561.563153105424, 14713.779293310823, 14740.189289589176, 12321.445534951128, 12402.441890114786, 12409.44157512896, 12871.485140594272, 13025.283609401195, 11408.0, 11453.19827612059, 11484.192632314307, 11617.419129043345, 11876.465559049691, 10581.4709264538, 11252.887471125185, 11327.263727857662, 11441.544833092294, 11887.346195959306], "value": 7608.265459807658, "unit": "score"}], "name": "dromaeo_css", "value": 7202.419602007045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 109.0, 110.0, 111.0, 112.0, 112.0, 111.0, 114.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 123.0, 172.0, 117.0, 120.0, 147.0, 116.0, 151.0, 118.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 171.0, 164.0, 165.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 110.0, 75.0, 75.0, 74.0, 75.0, 99.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 129.0, 84.0, 85.0, 85.0, 117.0, 86.0, 84.0, 135.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 49.0, 50.0, 50.0, 50.0, 50.0, 52.0, 49.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 75.0, 84.0, 79.0, 76.0, 76.0, 75.0, 74.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 129.0, 129.0, 118.0, 124.0, 122.0, 120.0, 138.0, 130.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 158.0, 159.0, 161.0, 158.0, 157.0, 157.0, 158.0, 159.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 69.0, 62.0, 64.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1475.3000000000002, "alertThreshold": 2.0}]} 05:34:50 INFO - Return code: 0 05:34:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:34:50 INFO - # TBPL SUCCESS # 05:34:50 INFO - Running post-action listener: _resource_record_post_action 05:34:50 INFO - [mozharness: 2016-08-09 12:34:50.188621Z] Finished run-tests step (success) 05:34:50 INFO - Running post-run listener: _resource_record_post_run 05:34:50 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552951808; Read time: 12; Write time: 676944 05:34:50 INFO - TinderboxPrint: CPU usage
13.1% 05:34:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:34:50 INFO - TinderboxPrint: I/O write bytes / time
552,951,808 / 676,944 05:34:50 INFO - TinderboxPrint: CPU idle
8,272.7 (86.9%) 05:34:50 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 05:34:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:34:50 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 259059712; Read time: 0; Write time: 354500 05:34:50 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 293892096; Read time: 0; Write time: 322444 05:34:50 INFO - Running post-run listener: _upload_blobber_files 05:34:50 INFO - Blob upload gear active. 05:34:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:34:50 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 05:34:50 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'] 05:34:50 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 05:34:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:34:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:54 INFO - (blobuploader) - INFO - Done attempting. 05:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:34:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:55 INFO - (blobuploader) - INFO - Done attempting. 05:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:34:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:55 INFO - (blobuploader) - INFO - Done attempting. 05:34:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:55 INFO - Return code: 0 05:34:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:34:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2224476400ed9115b461ed3c2f7ba366c48bf57274b64cb0fe0519fdb28149be97fce85e251004093fd29e3ffff2cc1a1515abefd91d95b2cf1ef046370e9b41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af3745a107e5483ba2e5ed528848791c1267e9ce34ba557424927f115ea70c57ebe59214d432efc51455721abbb8ae4f06110e5aeb8e218b7fd9023e5e605656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91ae8fd83f22de7ecb6b4c6c125daa8a7d768277578873b5869ea59c80db028fb08e228a6c048cf9bda71c79dc6598b4547ab3f5c5c593ac9b9ce15efe45d91"} 05:34:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:34:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:34:55 INFO - Contents: 05:34:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2224476400ed9115b461ed3c2f7ba366c48bf57274b64cb0fe0519fdb28149be97fce85e251004093fd29e3ffff2cc1a1515abefd91d95b2cf1ef046370e9b41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af3745a107e5483ba2e5ed528848791c1267e9ce34ba557424927f115ea70c57ebe59214d432efc51455721abbb8ae4f06110e5aeb8e218b7fd9023e5e605656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91ae8fd83f22de7ecb6b4c6c125daa8a7d768277578873b5869ea59c80db028fb08e228a6c048cf9bda71c79dc6598b4547ab3f5c5c593ac9b9ce15efe45d91"} 05:34:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:55 INFO - Copying logs to upload dir... 05:34:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:34:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.294952 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-09 05:34:55.781417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:34:55.784688) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717 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/2224476400ed9115b461ed3c2f7ba366c48bf57274b64cb0fe0519fdb28149be97fce85e251004093fd29e3ffff2cc1a1515abefd91d95b2cf1ef046370e9b41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af3745a107e5483ba2e5ed528848791c1267e9ce34ba557424927f115ea70c57ebe59214d432efc51455721abbb8ae4f06110e5aeb8e218b7fd9023e5e605656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91ae8fd83f22de7ecb6b4c6c125daa8a7d768277578873b5869ea59c80db028fb08e228a6c048cf9bda71c79dc6598b4547ab3f5c5c593ac9b9ce15efe45d91"} build_url:https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/Ifq41U5RRmGqXOYvysNv9A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2224476400ed9115b461ed3c2f7ba366c48bf57274b64cb0fe0519fdb28149be97fce85e251004093fd29e3ffff2cc1a1515abefd91d95b2cf1ef046370e9b41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af3745a107e5483ba2e5ed528848791c1267e9ce34ba557424927f115ea70c57ebe59214d432efc51455721abbb8ae4f06110e5aeb8e218b7fd9023e5e605656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91ae8fd83f22de7ecb6b4c6c125daa8a7d768277578873b5869ea59c80db028fb08e228a6c048cf9bda71c79dc6598b4547ab3f5c5c593ac9b9ce15efe45d91"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:34:55.810491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:34:55.810888) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470741943.670508-288258717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005084 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:34:55.896390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:34:55.896711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:34:55.897023) ========= ========= Total master_lag: 0.19 =========