builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1472184771.12 results: success (0) buildid: 20160825200512 builduid: cbc4e37c997c43de9f48b50eeca41e9c revision: b7e8b15d90da87ca0491b9515ca8640f97ef132e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.122516) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.123242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.123527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.176695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.176973) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 21:12:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-08-25 21:12:51 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119293 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.320266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.320559) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015101 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.373759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:51.374106) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7e8b15d90da87ca0491b9515ca8640f97ef132e --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 b7e8b15d90da87ca0491b9515ca8640f97ef132e --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=5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 21:12:51,623 truncating revision to first 12 chars 2016-08-25 21:12:51,623 Setting DEBUG logging. 2016-08-25 21:12:51,623 attempt 1/10 2016-08-25 21:12:51,623 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7e8b15d90da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 21:12:52,131 unpacking tar archive at: fx-team-b7e8b15d90da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.863831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:52.251310) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:52.251672) ========= script_repo_revision: b7e8b15d90da87ca0491b9515ca8640f97ef132e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:52.252101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:52.252375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 21:12:52.261228) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-25 21:12:52.367542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:12:52 INFO - MultiFileLogger online at 20160825 21:12:52 in /builds/slave/test 21:12:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:12:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:12:52 INFO - {'append_to_log': False, 21:12:52 INFO - 'base_work_dir': '/builds/slave/test', 21:12:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:12:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:12:52 INFO - 'branch': 'Fx-Team-Non-PGO', 21:12:52 INFO - 'buildbot_json_path': 'buildprops.json', 21:12:52 INFO - 'config_files': ('talos/linux_config.py',), 21:12:52 INFO - 'default_actions': ('clobber', 21:12:52 INFO - 'read-buildbot-config', 21:12:52 INFO - 'download-and-extract', 21:12:52 INFO - 'populate-webroot', 21:12:52 INFO - 'create-virtualenv', 21:12:52 INFO - 'install', 21:12:52 INFO - 'run-tests'), 21:12:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:12:52 INFO - 'download_minidump_stackwalk': True, 21:12:52 INFO - 'download_symbols': 'ondemand', 21:12:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:12:52 INFO - 'tooltool.py': '/tools/tooltool.py', 21:12:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:12:52 INFO - '/tools/misc-python/virtualenv.py')}, 21:12:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:12:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:12:52 INFO - 'installer_path': 'installer.exe', 21:12:52 INFO - 'log_level': 'info', 21:12:52 INFO - 'log_name': 'talos', 21:12:52 INFO - 'log_to_console': True, 21:12:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:12:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:12:52 INFO - 'opt_config_files': (), 21:12:52 INFO - 'pip_index': False, 21:12:52 INFO - 'sps_profile': False, 21:12:52 INFO - 'sps_profile_interval': 0, 21:12:52 INFO - 'suite': 'dromaeojs', 21:12:52 INFO - 'system_bits': '32', 21:12:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:12:52 INFO - 'title': 'talos-linux64-ix-011', 21:12:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:12:52 INFO - 'use_talos_json': True, 21:12:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:12:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:12:52 INFO - 'work_dir': 'build'} 21:12:52 INFO - [mozharness: 2016-08-26 04:12:52.711510Z] Running clobber step. 21:12:52 INFO - Running pre-action listener: _resource_record_pre_action 21:12:52 INFO - Running main action method: clobber 21:12:52 INFO - rmtree: /builds/slave/test/build 21:12:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:12:53 INFO - Running post-action listener: _resource_record_post_action 21:12:53 INFO - [mozharness: 2016-08-26 04:12:53.698403Z] Finished clobber step (success) 21:12:53 INFO - [mozharness: 2016-08-26 04:12:53.698504Z] Running read-buildbot-config step. 21:12:53 INFO - Running pre-action listener: _resource_record_pre_action 21:12:53 INFO - Running main action method: read_buildbot_config 21:12:53 INFO - Using buildbot properties: 21:12:53 INFO - { 21:12:53 INFO - "project": "", 21:12:53 INFO - "product": "firefox", 21:12:53 INFO - "script_repo_revision": "production", 21:12:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:12:53 INFO - "repository": "", 21:12:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:12:53 INFO - "buildid": "20160825200512", 21:12:53 INFO - "pgo_build": "False", 21:12:53 INFO - "basedir": "/builds/slave/test", 21:12:53 INFO - "buildnumber": 1886, 21:12:53 INFO - "slavename": "talos-linux64-ix-011", 21:12:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:12:53 INFO - "platform": "ubuntu64_hw", 21:12:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:12:53 INFO - "branch": "fx-team", 21:12:53 INFO - "repo_path": "integration/fx-team", 21:12:53 INFO - "revision": "b7e8b15d90da87ca0491b9515ca8640f97ef132e", 21:12:53 INFO - "stage_platform": "linux64", 21:12:53 INFO - "builduid": "cbc4e37c997c43de9f48b50eeca41e9c", 21:12:53 INFO - "slavebuilddir": "test" 21:12:53 INFO - } 21:12:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:12:53 INFO - Running post-action listener: _resource_record_post_action 21:12:53 INFO - [mozharness: 2016-08-26 04:12:53.700931Z] Finished read-buildbot-config step (success) 21:12:53 INFO - [mozharness: 2016-08-26 04:12:53.701020Z] Running download-and-extract step. 21:12:53 INFO - Running pre-action listener: _resource_record_pre_action 21:12:53 INFO - Running main action method: download_and_extract 21:12:53 INFO - mkdir: /builds/slave/test/build/tests 21:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:53 INFO - trying https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:12:53 INFO - Downloading https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:12:54 INFO - Downloaded 1361 bytes. 21:12:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:12:54 INFO - Using the following test package requirements: 21:12:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:12:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:12:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:12:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'jsshell-linux-x86_64.zip'], 21:12:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:12:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:12:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:12:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:12:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:12:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:12:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:12:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:54 INFO - trying https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:12:54 INFO - Downloading https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:12:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:12:55 INFO - Downloaded 20300824 bytes. 21:12:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 21:12:59 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 21:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:59 INFO - trying https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:12:59 INFO - Downloading https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:13:00 INFO - Downloaded 20300824 bytes. 21:13:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 21:13:04 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')]} 21:13:04 INFO - trying https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:13:04 INFO - Downloading https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:13:05 INFO - Downloaded 14413981 bytes. 21:13:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 21:13:05 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')]} 21:13:05 INFO - trying https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:13:05 INFO - Downloading https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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 21:13:08 INFO - Downloaded 55900490 bytes. 21:13:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:13:08 INFO - mkdir: /builds/slave/test/properties 21:13:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:08 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:08 INFO - Contents: 21:13:08 INFO - build_url:https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:13:08 INFO - Running post-action listener: _resource_record_post_action 21:13:08 INFO - Running post-action listener: set_extra_try_arguments 21:13:08 INFO - [mozharness: 2016-08-26 04:13:08.742654Z] Finished download-and-extract step (success) 21:13:08 INFO - [mozharness: 2016-08-26 04:13:08.742880Z] Running populate-webroot step. 21:13:08 INFO - Running pre-action listener: _resource_record_pre_action 21:13:08 INFO - Running main action method: populate_webroot 21:13:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:13:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:13:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:13:08 INFO - '--tppagecycles', 21:13:08 INFO - '7'], 21:13:08 INFO - 'tests': ['tsvgm']}}, 21:13:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:13:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:13:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:13:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:13:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['damp', 'tps']}, 21:13:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'tests': ['damp', 'tps']}, 21:13:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['dromaeo_dom']}, 21:13:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:13:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['basic_compositor_video']}, 21:13:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:13:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['a11yr', 21:13:08 INFO - 'ts_paint', 21:13:08 INFO - 'tpaint', 21:13:08 INFO - 'sessionrestore', 21:13:08 INFO - 'sessionrestore_no_auto_restore', 21:13:08 INFO - 'tabpaint']}, 21:13:08 INFO - 'other-e10s': {'tests': ['a11yr', 21:13:08 INFO - 'ts_paint', 21:13:08 INFO - 'tpaint', 21:13:08 INFO - 'sessionrestore', 21:13:08 INFO - 'sessionrestore_no_auto_restore', 21:13:08 INFO - 'tabpaint']}, 21:13:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:13:08 INFO - 'ts_paint', 21:13:08 INFO - 'tpaint', 21:13:08 INFO - 'sessionrestore', 21:13:08 INFO - 'sessionrestore_no_auto_restore', 21:13:08 INFO - 'tabpaint']}, 21:13:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:13:08 INFO - 'ts_paint', 21:13:08 INFO - 'tpaint', 21:13:08 INFO - 'sessionrestore', 21:13:08 INFO - 'sessionrestore_no_auto_restore', 21:13:08 INFO - 'tabpaint']}, 21:13:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['a11yr', 21:13:08 INFO - 'ts_paint', 21:13:08 INFO - 'tpaint', 21:13:08 INFO - 'sessionrestore', 21:13:08 INFO - 'sessionrestore_no_auto_restore', 21:13:08 INFO - 'tabpaint']}, 21:13:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['a11yr', 21:13:08 INFO - 'ts_paint', 21:13:08 INFO - 'tpaint', 21:13:08 INFO - 'sessionrestore', 21:13:08 INFO - 'sessionrestore_no_auto_restore', 21:13:08 INFO - 'tabpaint']}, 21:13:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['tsvgx', 21:13:08 INFO - 'tsvgr_opacity', 21:13:08 INFO - 'tart', 21:13:08 INFO - 'tscrollx', 21:13:08 INFO - 'cart']}, 21:13:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:13:08 INFO - 'tsvgr_opacity', 21:13:08 INFO - 'tart', 21:13:08 INFO - 'tscrollx', 21:13:08 INFO - 'cart']}, 21:13:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'talos_options': ['--disable-e10s'], 21:13:08 INFO - 'tests': ['tp5o']}, 21:13:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'tests': ['tp5o']}, 21:13:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'talos_options': ['--disable-e10s', 21:13:08 INFO - '--xperf_path', 21:13:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:08 INFO - 'tests': ['tp5n']}, 21:13:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:08 INFO - 'talos_options': ['--xperf_path', 21:13:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:08 INFO - 'tests': ['tp5n']}}, 21:13:08 INFO - 'talos.zip': {'path': '', 21:13:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:13:08 INFO - Running post-action listener: _resource_record_post_action 21:13:08 INFO - [mozharness: 2016-08-26 04:13:08.760355Z] Finished populate-webroot step (success) 21:13:08 INFO - [mozharness: 2016-08-26 04:13:08.760445Z] Running create-virtualenv step. 21:13:08 INFO - Running pre-action listener: _resource_record_pre_action 21:13:08 INFO - Running main action method: create_virtualenv 21:13:08 INFO - Creating virtualenv /builds/slave/test/build/venv 21:13:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:13:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:13:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:13:08 INFO - Using real prefix '/usr' 21:13:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:13:09 INFO - Installing distribute.............................................................................................................................................................................................done. 21:13:11 INFO - Installing pip.................done. 21:13:11 INFO - Return code: 0 21:13:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:11 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:13:11 INFO - Using env: {'DISPLAY': ':0', 21:13:11 INFO - 'HOME': '/home/cltbld', 21:13:11 INFO - 'LANG': 'en_US.UTF-8', 21:13:11 INFO - 'LANGUAGE': 'en_US:en', 21:13:11 INFO - 'LOGNAME': 'cltbld', 21:13:11 INFO - 'MAIL': '/var/mail/cltbld', 21:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:11 INFO - 'MOZ_NO_REMOTE': '1', 21:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:11 INFO - 'NO_EM_RESTART': '1', 21:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:11 INFO - 'PWD': '/builds/slave/test', 21:13:11 INFO - 'SHELL': '/bin/bash', 21:13:11 INFO - 'SHLVL': '1', 21:13:11 INFO - 'TERM': 'linux', 21:13:11 INFO - 'TMOUT': '86400', 21:13:11 INFO - 'USER': 'cltbld', 21:13:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:11 INFO - '_': '/tools/buildbot/bin/python'} 21:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:13:11 INFO - Cleaning up... 21:13:11 INFO - Return code: 0 21:13:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:11 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:13:11 INFO - Using env: {'DISPLAY': ':0', 21:13:11 INFO - 'HOME': '/home/cltbld', 21:13:11 INFO - 'LANG': 'en_US.UTF-8', 21:13:11 INFO - 'LANGUAGE': 'en_US:en', 21:13:11 INFO - 'LOGNAME': 'cltbld', 21:13:11 INFO - 'MAIL': '/var/mail/cltbld', 21:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:11 INFO - 'MOZ_NO_REMOTE': '1', 21:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:11 INFO - 'NO_EM_RESTART': '1', 21:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:11 INFO - 'PWD': '/builds/slave/test', 21:13:11 INFO - 'SHELL': '/bin/bash', 21:13:11 INFO - 'SHLVL': '1', 21:13:11 INFO - 'TERM': 'linux', 21:13:11 INFO - 'TMOUT': '86400', 21:13:11 INFO - 'USER': 'cltbld', 21:13:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:11 INFO - '_': '/tools/buildbot/bin/python'} 21:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:11 INFO - Downloading/unpacking psutil>=3.1.1 21:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:13:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:13 INFO - Installing collected packages: psutil 21:13:13 INFO - Running setup.py install for psutil 21:13:13 INFO - building 'psutil._psutil_linux' extension 21:13:13 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 21:13:14 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 21:13:14 INFO - building 'psutil._psutil_posix' extension 21:13:14 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 21:13:14 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 21:13:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:14 INFO - Successfully installed psutil 21:13:14 INFO - Cleaning up... 21:13:14 INFO - Return code: 0 21:13:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:14 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:13:14 INFO - Using env: {'DISPLAY': ':0', 21:13:14 INFO - 'HOME': '/home/cltbld', 21:13:14 INFO - 'LANG': 'en_US.UTF-8', 21:13:14 INFO - 'LANGUAGE': 'en_US:en', 21:13:14 INFO - 'LOGNAME': 'cltbld', 21:13:14 INFO - 'MAIL': '/var/mail/cltbld', 21:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:14 INFO - 'MOZ_NO_REMOTE': '1', 21:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:14 INFO - 'NO_EM_RESTART': '1', 21:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:14 INFO - 'PWD': '/builds/slave/test', 21:13:14 INFO - 'SHELL': '/bin/bash', 21:13:14 INFO - 'SHLVL': '1', 21:13:14 INFO - 'TERM': 'linux', 21:13:14 INFO - 'TMOUT': '86400', 21:13:14 INFO - 'USER': 'cltbld', 21:13:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:14 INFO - '_': '/tools/buildbot/bin/python'} 21:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:13:16 INFO - Installing collected packages: mozsystemmonitor 21:13:16 INFO - Running setup.py install for mozsystemmonitor 21:13:16 INFO - Successfully installed mozsystemmonitor 21:13:16 INFO - Cleaning up... 21:13:16 INFO - Return code: 0 21:13:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:13:16 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')]} 21:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:16 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')]} 21:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:16 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:13:16 INFO - Using env: {'DISPLAY': ':0', 21:13:16 INFO - 'HOME': '/home/cltbld', 21:13:16 INFO - 'LANG': 'en_US.UTF-8', 21:13:16 INFO - 'LANGUAGE': 'en_US:en', 21:13:16 INFO - 'LOGNAME': 'cltbld', 21:13:16 INFO - 'MAIL': '/var/mail/cltbld', 21:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:16 INFO - 'MOZ_NO_REMOTE': '1', 21:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:16 INFO - 'NO_EM_RESTART': '1', 21:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:16 INFO - 'PWD': '/builds/slave/test', 21:13:16 INFO - 'SHELL': '/bin/bash', 21:13:16 INFO - 'SHLVL': '1', 21:13:16 INFO - 'TERM': 'linux', 21:13:16 INFO - 'TMOUT': '86400', 21:13:16 INFO - 'USER': 'cltbld', 21:13:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:16 INFO - '_': '/tools/buildbot/bin/python'} 21:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:16 INFO - Downloading/unpacking jsonschema==2.5.1 21:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:13:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:13:18 INFO - warning: no files found matching '*.txt' 21:13:18 INFO - no previously-included directories found matching 'build' 21:13:18 INFO - no previously-included directories found matching 'dist' 21:13:18 INFO - no previously-included directories found matching '.git*' 21:13:18 INFO - Installing collected packages: jsonschema, functools32 21:13:19 INFO - Running setup.py install for functools32 21:13:19 INFO - warning: no files found matching '*.txt' 21:13:19 INFO - no previously-included directories found matching 'build' 21:13:19 INFO - no previously-included directories found matching 'dist' 21:13:19 INFO - no previously-included directories found matching '.git*' 21:13:19 INFO - Successfully installed jsonschema functools32 21:13:19 INFO - Cleaning up... 21:13:19 INFO - Return code: 0 21:13:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:19 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:19 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 21:13:19 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 21:13:19 INFO - Using env: {'DISPLAY': ':0', 21:13:19 INFO - 'HOME': '/home/cltbld', 21:13:19 INFO - 'LANG': 'en_US.UTF-8', 21:13:19 INFO - 'LANGUAGE': 'en_US:en', 21:13:19 INFO - 'LOGNAME': 'cltbld', 21:13:19 INFO - 'MAIL': '/var/mail/cltbld', 21:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:19 INFO - 'MOZ_NO_REMOTE': '1', 21:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:19 INFO - 'NO_EM_RESTART': '1', 21:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:19 INFO - 'PWD': '/builds/slave/test', 21:13:19 INFO - 'SHELL': '/bin/bash', 21:13:19 INFO - 'SHLVL': '1', 21:13:19 INFO - 'TERM': 'linux', 21:13:19 INFO - 'TMOUT': '86400', 21:13:19 INFO - 'USER': 'cltbld', 21:13:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:19 INFO - '_': '/tools/buildbot/bin/python'} 21:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:13:19 INFO - Cleaning up... 21:13:19 INFO - Return code: 0 21:13:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:19 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:13:19 INFO - Using env: {'DISPLAY': ':0', 21:13:19 INFO - 'HOME': '/home/cltbld', 21:13:19 INFO - 'LANG': 'en_US.UTF-8', 21:13:19 INFO - 'LANGUAGE': 'en_US:en', 21:13:19 INFO - 'LOGNAME': 'cltbld', 21:13:19 INFO - 'MAIL': '/var/mail/cltbld', 21:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:19 INFO - 'MOZ_NO_REMOTE': '1', 21:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:19 INFO - 'NO_EM_RESTART': '1', 21:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:19 INFO - 'PWD': '/builds/slave/test', 21:13:19 INFO - 'SHELL': '/bin/bash', 21:13:19 INFO - 'SHLVL': '1', 21:13:19 INFO - 'TERM': 'linux', 21:13:19 INFO - 'TMOUT': '86400', 21:13:19 INFO - 'USER': 'cltbld', 21:13:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:19 INFO - '_': '/tools/buildbot/bin/python'} 21:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:13:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:13:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:22 INFO - Downloading docopt-0.6.1.tar.gz 21:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:13:22 INFO - Installing collected packages: blobuploader, requests, docopt 21:13:22 INFO - Running setup.py install for blobuploader 21:13:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:13:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:13:22 INFO - Running setup.py install for requests 21:13:22 INFO - Running setup.py install for docopt 21:13:22 INFO - Successfully installed blobuploader requests docopt 21:13:22 INFO - Cleaning up... 21:13:22 INFO - Return code: 0 21:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:22 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')]} 21:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:22 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')]} 21:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:22 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:13:22 INFO - Using env: {'DISPLAY': ':0', 21:13:22 INFO - 'HOME': '/home/cltbld', 21:13:22 INFO - 'LANG': 'en_US.UTF-8', 21:13:22 INFO - 'LANGUAGE': 'en_US:en', 21:13:22 INFO - 'LOGNAME': 'cltbld', 21:13:22 INFO - 'MAIL': '/var/mail/cltbld', 21:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:22 INFO - 'MOZ_NO_REMOTE': '1', 21:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:22 INFO - 'NO_EM_RESTART': '1', 21:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:22 INFO - 'PWD': '/builds/slave/test', 21:13:22 INFO - 'SHELL': '/bin/bash', 21:13:22 INFO - 'SHLVL': '1', 21:13:22 INFO - 'TERM': 'linux', 21:13:22 INFO - 'TMOUT': '86400', 21:13:22 INFO - 'USER': 'cltbld', 21:13:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:22 INFO - '_': '/tools/buildbot/bin/python'} 21:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:23 INFO - Running setup.py (path:/tmp/pip-Fva6t7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:23 INFO - Running setup.py (path:/tmp/pip-xZ_BWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:23 INFO - Running setup.py (path:/tmp/pip-8AEzox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:23 INFO - Running setup.py (path:/tmp/pip-iEQkIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:23 INFO - Running setup.py (path:/tmp/pip-UW1XH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:23 INFO - Running setup.py (path:/tmp/pip-BgskMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:23 INFO - Running setup.py (path:/tmp/pip-bTEC8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:23 INFO - Running setup.py (path:/tmp/pip-hMaQ0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:23 INFO - Running setup.py (path:/tmp/pip-wC1p1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:23 INFO - Running setup.py (path:/tmp/pip-iCY6c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:23 INFO - Running setup.py (path:/tmp/pip-nBgl8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:23 INFO - Running setup.py (path:/tmp/pip-wPzNOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:23 INFO - Running setup.py (path:/tmp/pip-6xe_gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:23 INFO - Running setup.py (path:/tmp/pip-Q_omZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:24 INFO - Running setup.py (path:/tmp/pip-9QhnLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:24 INFO - Running setup.py (path:/tmp/pip-SHg0rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:24 INFO - Running setup.py (path:/tmp/pip-J9NE9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:13:24 INFO - Running setup.py install for manifestparser 21:13:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:13:24 INFO - Running setup.py install for mozcrash 21:13:24 INFO - Running setup.py install for mozdebug 21:13:24 INFO - Running setup.py install for mozdevice 21:13:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:13:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:13:24 INFO - Running setup.py install for mozfile 21:13:24 INFO - Running setup.py install for mozhttpd 21:13:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:13:24 INFO - Running setup.py install for mozinfo 21:13:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:13:24 INFO - Running setup.py install for mozInstall 21:13:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Running setup.py install for mozleak 21:13:25 INFO - Running setup.py install for mozlog 21:13:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Running setup.py install for moznetwork 21:13:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Running setup.py install for mozprocess 21:13:25 INFO - Running setup.py install for mozprofile 21:13:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Running setup.py install for mozrunner 21:13:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:13:25 INFO - Running setup.py install for mozscreenshot 21:13:25 INFO - Running setup.py install for moztest 21:13:25 INFO - Running setup.py install for mozversion 21:13:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:13:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:13:26 INFO - Cleaning up... 21:13:26 INFO - Return code: 0 21:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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')]} 21:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:26 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:13:26 INFO - Using env: {'DISPLAY': ':0', 21:13:26 INFO - 'HOME': '/home/cltbld', 21:13:26 INFO - 'LANG': 'en_US.UTF-8', 21:13:26 INFO - 'LANGUAGE': 'en_US:en', 21:13:26 INFO - 'LOGNAME': 'cltbld', 21:13:26 INFO - 'MAIL': '/var/mail/cltbld', 21:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:26 INFO - 'MOZ_NO_REMOTE': '1', 21:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:26 INFO - 'NO_EM_RESTART': '1', 21:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:26 INFO - 'PWD': '/builds/slave/test', 21:13:26 INFO - 'SHELL': '/bin/bash', 21:13:26 INFO - 'SHLVL': '1', 21:13:26 INFO - 'TERM': 'linux', 21:13:26 INFO - 'TMOUT': '86400', 21:13:26 INFO - 'USER': 'cltbld', 21:13:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:26 INFO - '_': '/tools/buildbot/bin/python'} 21:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:26 INFO - Running setup.py (path:/tmp/pip-c2V1dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:26 INFO - Running setup.py (path:/tmp/pip-SIt6cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:26 INFO - Running setup.py (path:/tmp/pip-7ImMd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:26 INFO - Running setup.py (path:/tmp/pip-ym9g4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:26 INFO - Running setup.py (path:/tmp/pip-x40yT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:26 INFO - Running setup.py (path:/tmp/pip-uhhTdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:26 INFO - Running setup.py (path:/tmp/pip-t6D1y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:26 INFO - Running setup.py (path:/tmp/pip-Uue0Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:26 INFO - Running setup.py (path:/tmp/pip-LSRDqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:26 INFO - Running setup.py (path:/tmp/pip-Ty24qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:26 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)) 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:26 INFO - Running setup.py (path:/tmp/pip-iyjGsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:27 INFO - Running setup.py (path:/tmp/pip-0hBMPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:27 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)) 21:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:27 INFO - Running setup.py (path:/tmp/pip-kGPjG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:27 INFO - Running setup.py (path:/tmp/pip-pdG62P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:27 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)) 21:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:27 INFO - Running setup.py (path:/tmp/pip-wIhqxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:27 INFO - Running setup.py (path:/tmp/pip-MaiO6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:27 INFO - Running setup.py (path:/tmp/pip-bFcQy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:13:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:29 INFO - Downloading blessings-1.6.tar.gz 21:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:13:29 INFO - Installing collected packages: blessings 21:13:29 INFO - Running setup.py install for blessings 21:13:29 INFO - Successfully installed blessings 21:13:29 INFO - Cleaning up... 21:13:29 INFO - Return code: 0 21:13:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:30 INFO - Reading from file tmpfile_stdout 21:13:30 INFO - Current package versions: 21:13:30 INFO - argparse == 1.2.1 21:13:30 INFO - blessings == 1.6 21:13:30 INFO - blobuploader == 1.2.4 21:13:30 INFO - docopt == 0.6.1 21:13:30 INFO - functools32 == 3.2.3-2 21:13:30 INFO - jsonschema == 2.5.1 21:13:30 INFO - manifestparser == 1.1 21:13:30 INFO - mozInstall == 1.12 21:13:30 INFO - mozcrash == 0.17 21:13:30 INFO - mozdebug == 0.1 21:13:30 INFO - mozdevice == 0.48 21:13:30 INFO - mozfile == 1.2 21:13:30 INFO - mozhttpd == 0.7 21:13:30 INFO - mozinfo == 0.9 21:13:30 INFO - mozleak == 0.1 21:13:30 INFO - mozlog == 3.3 21:13:30 INFO - moznetwork == 0.27 21:13:30 INFO - mozprocess == 0.23 21:13:30 INFO - mozprofile == 0.28 21:13:30 INFO - mozrunner == 6.12 21:13:30 INFO - mozscreenshot == 0.1 21:13:30 INFO - mozsystemmonitor == 0.3 21:13:30 INFO - moztest == 0.7 21:13:30 INFO - mozversion == 1.4 21:13:30 INFO - psutil == 3.1.1 21:13:30 INFO - requests == 1.2.3 21:13:30 INFO - wsgiref == 0.1.2 21:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:30 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:13:30 INFO - Using env: {'DISPLAY': ':0', 21:13:30 INFO - 'HOME': '/home/cltbld', 21:13:30 INFO - 'LANG': 'en_US.UTF-8', 21:13:30 INFO - 'LANGUAGE': 'en_US:en', 21:13:30 INFO - 'LOGNAME': 'cltbld', 21:13:30 INFO - 'MAIL': '/var/mail/cltbld', 21:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:30 INFO - 'MOZ_NO_REMOTE': '1', 21:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:30 INFO - 'NO_EM_RESTART': '1', 21:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:30 INFO - 'PWD': '/builds/slave/test', 21:13:30 INFO - 'SHELL': '/bin/bash', 21:13:30 INFO - 'SHLVL': '1', 21:13:30 INFO - 'TERM': 'linux', 21:13:30 INFO - 'TMOUT': '86400', 21:13:30 INFO - 'USER': 'cltbld', 21:13:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:30 INFO - '_': '/tools/buildbot/bin/python'} 21:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:13:30 INFO - Cleaning up... 21:13:30 INFO - Return code: 0 21:13:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:30 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 0x7f9993be2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', '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 21:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:13:30 INFO - Using env: {'DISPLAY': ':0', 21:13:30 INFO - 'HOME': '/home/cltbld', 21:13:30 INFO - 'LANG': 'en_US.UTF-8', 21:13:30 INFO - 'LANGUAGE': 'en_US:en', 21:13:30 INFO - 'LOGNAME': 'cltbld', 21:13:30 INFO - 'MAIL': '/var/mail/cltbld', 21:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:30 INFO - 'MOZ_NO_REMOTE': '1', 21:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:30 INFO - 'NO_EM_RESTART': '1', 21:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:30 INFO - 'PWD': '/builds/slave/test', 21:13:30 INFO - 'SHELL': '/bin/bash', 21:13:30 INFO - 'SHLVL': '1', 21:13:30 INFO - 'TERM': 'linux', 21:13:30 INFO - 'TMOUT': '86400', 21:13:30 INFO - 'USER': 'cltbld', 21:13:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:30 INFO - '_': '/tools/buildbot/bin/python'} 21:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:13:30 INFO - Cleaning up... 21:13:30 INFO - Return code: 0 21:13:30 INFO - Running post-action listener: _resource_record_post_action 21:13:30 INFO - Running post-action listener: _start_resource_monitoring 21:13:30 INFO - Starting resource monitoring. 21:13:30 INFO - [mozharness: 2016-08-26 04:13:30.485034Z] Finished create-virtualenv step (success) 21:13:30 INFO - [mozharness: 2016-08-26 04:13:30.485611Z] Running install step. 21:13:30 INFO - Running pre-action listener: _resource_record_pre_action 21:13:30 INFO - Running main action method: install 21:13:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:30 INFO - Reading from file tmpfile_stdout 21:13:30 INFO - Detecting whether we're running mozinstall >=1.0... 21:13:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:13:30 INFO - Reading from file tmpfile_stdout 21:13:30 INFO - Output received: 21:13:30 INFO - Usage: mozinstall [options] installer 21:13:30 INFO - Options: 21:13:30 INFO - -h, --help show this help message and exit 21:13:30 INFO - -d DEST, --destination=DEST 21:13:30 INFO - Directory to install application into. [default: 21:13:30 INFO - "/builds/slave/test"] 21:13:30 INFO - --app=APP Application being installed. [default: firefox] 21:13:30 INFO - mkdir: /builds/slave/test/build/application 21:13:30 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'] 21:13:30 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 21:13:46 INFO - Reading from file tmpfile_stdout 21:13:46 INFO - Output received: 21:13:46 INFO - /builds/slave/test/build/application/firefox/firefox 21:13:46 INFO - Running post-action listener: _resource_record_post_action 21:13:46 INFO - [mozharness: 2016-08-26 04:13:46.957221Z] Finished install step (success) 21:13:46 INFO - [mozharness: 2016-08-26 04:13:46.957620Z] Running run-tests step. 21:13:46 INFO - Running pre-action listener: _resource_record_pre_action 21:13:46 INFO - Running main action method: run_tests 21:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:13:46 INFO - Python 2.7.3 21:13:46 INFO - Return code: 0 21:13:46 INFO - grabbing minidump binary from tooltool 21:13:46 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')]} 21:13:46 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 0x16fd090>, '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 0x17009b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1700e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:13:46 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 21:13:46 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 21:13:46 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 21:13:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:13:47 INFO - Return code: 0 21:13:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:13:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:13:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:13:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:13:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:13:47 INFO - Using env: {'DISPLAY': ':0', 21:13:47 INFO - 'HOME': '/home/cltbld', 21:13:47 INFO - 'LANG': 'en_US.UTF-8', 21:13:47 INFO - 'LANGUAGE': 'en_US:en', 21:13:47 INFO - 'LOGNAME': 'cltbld', 21:13:47 INFO - 'MAIL': '/var/mail/cltbld', 21:13:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:13:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:47 INFO - 'MOZ_NO_REMOTE': '1', 21:13:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:47 INFO - 'NO_EM_RESTART': '1', 21:13:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:47 INFO - 'PWD': '/builds/slave/test', 21:13:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:13:47 INFO - 'SHELL': '/bin/bash', 21:13:47 INFO - 'SHLVL': '1', 21:13:47 INFO - 'TERM': 'linux', 21:13:47 INFO - 'TMOUT': '86400', 21:13:47 INFO - 'USER': 'cltbld', 21:13:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683', 21:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:47 INFO - '_': '/tools/buildbot/bin/python'} 21:13:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:13:47 INFO - mozversion application_buildid: 20160825200512 21:13:47 INFO - mozversion application_changeset: b7e8b15d90da87ca0491b9515ca8640f97ef132e 21:13:47 INFO - mozversion application_display_name: Nightly 21:13:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:13:47 INFO - mozversion application_name: Firefox 21:13:47 INFO - mozversion application_remotingname: firefox 21:13:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:13:47 INFO - mozversion application_vendor: Mozilla 21:13:47 INFO - mozversion application_version: 51.0a1 21:13:47 INFO - mozversion platform_buildid: 20160825200512 21:13:47 INFO - mozversion platform_changeset: b7e8b15d90da87ca0491b9515ca8640f97ef132e 21:13:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:13:47 INFO - mozversion platform_version: 51.0a1 21:13:47 INFO - using testdate: 1472184827 21:13:47 INFO - actual date: 1472184827 21:13:47 INFO - starting webserver on 'localhost:52130' 21:13:47 INFO - SUITE-START | Running 2 tests 21:13:47 INFO - TEST-START | dromaeo_css 21:13:47 INFO - operating with platform_type : linux_ 21:13:47 INFO - Initialising browser for dromaeo_css test... 21:13:47 INFO - TEST-INFO | started process 5319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNvGmc/profile http://localhost:52130/getInfo.html) 21:13:52 INFO - PROCESS | 5319 | __metrics Screen width/height:1600/1200 21:13:52 INFO - PROCESS | 5319 | colorDepth:24 21:13:52 INFO - PROCESS | 5319 | Browser inner width/height: 1024/697 21:13:52 INFO - PROCESS | 5319 | __metrics 21:13:52 INFO - PROCESS | 5319 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:13:52 INFO - PROCESS | 5319 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:13:53 INFO - PROCESS | 5319 | console.error: PushService: 21:13:53 INFO - PROCESS | 5319 | stateChangeProcessEnqueue: Error transitioning state 21:13:53 INFO - PROCESS | 5319 | UnknownError 21:13:54 INFO - TEST-INFO | 5319: exit 0 21:13:54 INFO - Browser initialized. 21:13:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:13:54 INFO - TEST-INFO | started process 5399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJNvGmc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:14:06 INFO - PROCESS | 5399 | RSS: Main: 180580352 21:14:06 INFO - PROCESS | 5399 | 21:14:58 INFO - PROCESS | 5399 | 1472184898325 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:17:10 INFO - PROCESS | 5399 | Cycle 1(1): loaded http://localhost:52130/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52130/tests/dromaeo/cssquery-ext.html) 21:17:11 INFO - PROCESS | 5399 | RSS: Main: 263696384 21:17:11 INFO - PROCESS | 5399 | 21:20:14 INFO - PROCESS | 5399 | Cycle 1(1): loaded http://localhost:52130/tests/dromaeo/cssquery-ext.html (next: http://localhost:52130/tests/dromaeo/cssquery-jquery.html) 21:20:15 INFO - PROCESS | 5399 | RSS: Main: 275746816 21:20:15 INFO - PROCESS | 5399 | 21:23:17 INFO - PROCESS | 5399 | Cycle 1(1): loaded http://localhost:52130/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52130/tests/dromaeo/cssquery-mootools.html) 21:23:18 INFO - PROCESS | 5399 | RSS: Main: 219013120 21:23:18 INFO - PROCESS | 5399 | 21:26:20 INFO - PROCESS | 5399 | Cycle 1(1): loaded http://localhost:52130/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52130/tests/dromaeo/cssquery-prototype.html) 21:26:21 INFO - PROCESS | 5399 | RSS: Main: 231116800 21:26:21 INFO - PROCESS | 5399 | 21:29:24 INFO - PROCESS | 5399 | Cycle 1(1): loaded http://localhost:52130/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52130/tests/dromaeo/cssquery-yui.html) 21:29:25 INFO - PROCESS | 5399 | RSS: Main: 219471872 21:29:25 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | Cycle 1(1): loaded http://localhost:52130/tests/dromaeo/cssquery-yui.html (next: http://localhost:52130/tests/dromaeo/cssquery-dojo.html) 21:32:28 INFO - PROCESS | 5399 | RSS: Main: 301928448 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | __start_tp_report 21:32:28 INFO - PROCESS | 5399 | _x_x_mozilla_page_load 21:32:28 INFO - PROCESS | 5399 | _x_x_mozilla_page_load_details 21:32:28 INFO - PROCESS | 5399 | |i|pagename|runs| 21:32:28 INFO - PROCESS | 5399 | |0;dojo.html;2543.071778800738;2554.655121558589;2579.8839052242647;2584;2603.3101228174523;4575.794089265983;4635.281531362636;4640;4719.693219940706;4788.760561971901;4720.221163508017;4741.90516189676;4767.523247675231;4775.522447755223;4800.783964721579;4297.205017071836;4313.396124542551;4387;4458.754768487732;4520.683552151334;4416.094700586372;4469.932951005738;4479.372887795711;4497.505274419827;4522.592966633002;4253.2769429197115;4299.570042995707;4301.0537681709975;4357.869263922055;4386.978065109686;4307.095509942916;4334.45819272591;4365.476142862845;4380.408644832939;4415.690901636886;4333.978330108361;4395.472543294825;4400.6259467945265;4404.66964977628;4458.175237581057;4742.217534106868;4791.425028996543;4796.064767370364;4801.5438533339275;4862.027594481083;4954.108260513106;5004.449510553836;5050.191969284897;5072.2391641253735;5089.847304580869;5089.618278629081;5090.720010399426;5102.030614183293;5104.821331253388;5128.871778205537;4629.074185162981;4752.7623618818925;4755;4757.09615173116;4802.303665968415;5179.378474582999;5234.293370395024;5239.711815850089;5247.2653828464045;5317.760700768475;5020.5732512736095;5026.74866256693;5029.2958985742025;5031.396232452056;5090.974545127251;4897.338859253955;5110.974445127825;5121.308623335876;5122.692638441706;5132.0762262792305;4927.482614325444;4961.479044700327;4989.077020751172;5028.069807085701;5064.164412871909;4928.334674818925;4942.901141977212;4947.455779864212;4950.059488697136;5021.974890125526;4198.832046718158;4201.70588058833;4203.62167404935;4208.516020657602;4252.851150209728;3641.9817900910325;3644.817759112034;3669.889903302905;3728;3740.0275928258848;4409.470863496401;4410.80151393188;4454.10917816438;4462.152191083748;4466.0844526871915;5094.796208151706;5127.948720512822;5134.974325128351;5138.97430512845;5140.768665410065;4271.551487093872;4337.436133302651;4377.956220437755;4404.823807047746;4453.087117140978;4548.636109111263;4576.26779715244;4610.953890461053;4625.95374046262;4629.4676112247525;4730;4731.101090792738;4731.33761273422;4734.644901632322;4791.209450440639;4931.926021109614;5067.189249720027;5073.568746656428;5097.6941383517105;5100.79596816138;4704.9529504704515;4730.6215502759005;4735.313379560013;4774.379330687128;4785;5025.84922452327;5027.145385284437;5029.4719054498755;5040.269160971565;5079.390473143247;4974.825881094289;5022.874428139179;5025.74871256443;5103.081445339874;5186.507281808223;4845.830395936126;4877.829275975324;4918.2622606607865;4941.703497790144;4991.051700176955;4922.704637721748;4927.704337739747;4930.704157750403;4933.457319694902;4992.450830408725;4842.58837998774;4866.78099485531;4867.853964381075;4870.902581948412;4927.088488629615;4794.736289504111;4897.926531101965;4900.583450406755;4949.703017818798;5036.445990941067;4850.95149048505;4859.222524396079;4861.51384861511;4865.0756356292195;4927.384076990376 21:32:28 INFO - PROCESS | 5399 | |1;ext.html;553.3719228675453;558.5447859994102;577.3591313641859;580.895438821012;583.5185971573452;28254.85872570637;39039.804800976024;40485.59514404855;40555.79722101389;44174.33738493925;40825.7958710206;41324.58675413245;41331;41374;41390.37914431286;7649.08211014679;7790.493617914845;7804.453688241825;7807.336376408012;7809.531428114331;7293.051903252596;9654.13112819846;9853.753656158582;9863.161631261351;10156.492175391239;10051.748706282327;10066.697999060003;10084.949575252114;10137.341072830279;10153.695389138338;9936.254780891426;9971.70084897447;10003.649872254437;10006.949965250127;10014.799704005953;9478.38390504615;9561.665341713076;9561.808763824754;9578.185854202331;9583.377080489816;37944.81027594872;38237.61762382368;38248;38248.42627360592;38295.234095318214;3037.0888733379898;3047.588575542318;3066.156806878104;3091.0881290019497;3118.3139709263924;28905.29457863507;29389.265268368246;29719.405611887858;29796.40407191844;29866;3342.9832850835833;3354.194993201614;3384.509246159293;3542.096765324826;3551.3252482028333;255090;255777;256291;256665;257567;32708.345833083204;53108.734456328246;53655;53658;53721;33272.1681957953;33470;33492;33497.162570935434;33497.33005339928;12364.1963272387;12489;12494.687632809253;12497.437615307334;12508.437120329607;9385.718428447157;9767;9822.65620703272;9834.409935403899;10044.748881278027;7620.428467864932;7711.575863327571;7805.843883122306;7825.13923468418;7825.647845846951;3039.8480075996113;3053.92365190872;3070.7082827131385;3078.338157296192;3084.3214492811544;857.511218605389;867.7613656244583;870;894.2309613732185;937.8874535055837;27758.722412775613;28006.719932800817;28159;28491.85754071258;28588.857055714587;900.4372267332917;915.8214148241162;943.9103285187896;955.7562821480478;961.240619910277;14436.783448248285;14833.332500037308;15016.924915375354;15122.924385378003;15300;378741;379617;380955;381715;384095;48954.75522622364;49503.75248123809;49567.034637228935;49600.50399495959;49631;1031.798799234157;1136.4601814138384;1155.439611788282;1173.137743758354;1179.598936361641;25733.3566660835;28216;28780.568291475225;29292.707072929;29667;42295.7885210572;42694.78652606717;42777.78611106925;42818;42825.357619635106;286253;286790;286924;287272;287939;24525.50948981046;25853.482930341663;25905.48189036171;26928.192154235403;27003.1899043029;40963.18546284986;41334;41778.58221417747;42971;47203.29195062008;36101.638983609824;36327.27345453129;36425.63574364328;36429.45355819612;36932.81533592422;35296.64703353036;35382.8230858844;36125.638743612224;36188.63811361958;38085.80957095197;35256.64743352636;35549.46675799813;35921.28157436889;35967.28065438729;36025.63974360328;30964.535531966587;32969.505457417676;33484.162895927795;33911.491327630596;34025.82987085049;25302.367440814127;25462.872685636452;25606.743932560435;25673.442857213562;25679.486410272064 21:32:28 INFO - PROCESS | 5399 | |2;jquery.html;335.77503072941124;353.690520794305;365.48831635710013;369.12149085177276;379.73798079325263;12434;15823.762643560342;15941.76087358689;17095.40166094187;17260.827391726078;16397.672046559062;16642.25109870056;16905.83094169058;17035.91482042591;17059.658806823856;5008.649394542384;5039.748012599373;5074.974625126869;5145.485451454862;5165.147750621162;3636.945445818315;5117.462666420028;5127.897442051157;5722.170285308628;6028.336882942873;5992.460678538931;5999.340072592033;6015.939840601582;6030.487408570277;6034.969825150868;5069.721165335886;5295.126304159809;5325.094733895247;5407.783688652449;6034.883546543903;5224.947750522522;5235.528802407764;5238.528532432061;5238.8690282742855;5245.6852588844795;11922.821157682554;12177;12188.268703877795;12257.877421225763;12695;1844.787849397323;1861.4136546987656;1974.7827738948704;2119.9682004769943;2212.6570381590877;8866;9217.078292170729;9227.584758685874;11925.344106074162;12165.756684866341;1699.7110491216522;1719.3810228317795;1766.5495298698877;1782.4047477507559;1795.7429799140523;66597.79408095033;69546.17496037716;70525.2947470529;71438;72240;9684.273679474067;9871.210303175729;10014.949925250472;10222.948885255526;10296.433696146634;13733.519326823513;13738.725225495435;13739.313034348243;13758.93120534411;13771.449142034407;6751.864962700817;7109.324614161646;7120.572765633975;7260.41916646667;7302.926970730331;6633.86732265352;6681.516671758963;6878.34655707717;6889.311068893071;6953.269906659829;4201;4243.130158317537;4292.163028209469;4338.175746608197;4461.7992190351515;1656.8923020003901;1686.232764092335;1702.1914590569381;1729.5157355940357;1739.5477175934348;799.8960135182389;855.170484629908;865.9004214515286;889.3463304471209;927.8515437529962;15818.841811581737;16157;16291.674166516603;16453.83546164523;17079.413323202018;852.194676031157;859.9011113722003;891.1266958380694;893.2809088683542;902.1474706402518;8798.560071996375;9384;9447.433154010781;9452;9572.32993690435;390065;390778;394109;398944;400622;77962.61018694984;80348;80403;80430.59784701157;83263.5836820812;855.7603870916154;914.6707185413246;916.2486760856034;917.3945196170496;937.9624815007323;14997.550073497376;15252.084874907541;15352.923235383752;15743.44897928567;16033.518994430186;39769.80115099406;39902.60097398989;40268.79865600653;40819.183616328104;41610.37584436296;55086.17370739362;56052.159217610955;56115;57148.71425642845;57625;6442.162518872704;7506.3244308012545;7509.774706758806;7555.168931417649;7609.467337286337;8730.607122679621;10916;10921.576761411641;10981.670549883516;11140.387278699425;9073.863892041492;9672.322937394596;9745.756356091155;9766.951165244129;10309.74225644365;10344.844827327446;10543.525541350811;10571.207159463225;10645.308054976402;11011.73365063028;10205.642802501878;10215.795684086128;10307.896921030993;10352.792944140925;10624.946875265574;6366.395192456709;7316.597587132546;7487.962560187382;7552.886706699294;7592.924070759222;8195.83608327842;9442.339036267394;9822.557984890555;10105.24210684187;10152.847707284544 21:32:28 INFO - PROCESS | 5399 | |3;mootools.html;1216.6046035038614;1325.3969443903025;1368.931553422329;1436.7701167813145;1668.8915220510667;6500.739970401184;7782.922170778291;8037.839243215132;8038.6382612782345;8227.05388880279;8039.196080391973;8115.63479643416;8117.310028647572;8120.025596928362;8133.715319963802;2151.300827231148;2176.5864485747657;2178.5316157026236;2179.052112331141;2179.4333473296897;2130.7656157822626;2169.123707992583;2206.1175529788134;2208.4810069633622;2216.412650647572;1901.334532913476;1914.339552854263;1929.6140771845617;1935.874168179071;1965.2335589120255;2136.2309568555384;2146.9355919322447;2147.2162660628915;2149.2370208575967;2159.2118876609925;2065.349414934291;2137.732783402075;2140.3364956863265;2150.602138604363;2162.535054963175;7733.110692270405;7995.240452157036;8016.398770092266;8082.353411727047;8101.108878023413;4449.822007119711;4602.930956035662;4602.953970460319;4605.608523275526;4640.396748422717;2854.942901141986;2973.152651494314;3043.04144194578;3045.9695403045907;3052.222477545445;984.2273815055147;987.1954357198932;1001.7645853224486;1008.3193844155165;1012.7873146639215;10823.02592766647;10931.289466184673;10937.671869843918;10940.726481837939;10948.507317170746;4040.4141399496907;4292.334688123346;4487.88780280489;4505.324201369821;4509.301058335963;8568.871466928002;8642.740717778477;8645.308375329958;8647.26498247656;8649.308055355556;4515.1195516873895;4522.072975040109;4524.7285162889675;4525.52481989393;4527.524609915978;3600.3339382214376;3974.423708562242;4018.9196216075516;4225.7887105644595;4229.407882896397;3416.265502916835;3455.6371580984137;3501;3525.524054252643;3575.213453040327;924.7377329944711;932.128459890005;933.4446004627235;936.1481052242426;936.4896131608153;801.6592947997194;827.98344033119;829.6805729793952;836.3518273338211;840.5125027484045;5276.915618330738;5392.245085688007;5428.728563571805;5483.875805459871;5595.636283641632;822.942394032412;855.7518319687346;862.1163307609751;878.6968495868915;900.4237288135598;3666.651668091527;3821.063839359319;3823.9426408603895;3838.6353296436796;3939.527256729211;9554.092361225672;9836.376997795283;9991.550380232908;10040.14658754014;10060.849087263698;9990.750231244278;9993.10062094415;9999.50002499872;10001.199904007663;10002.699649045577;7287.708491660274;7448.068991376078;7541.47209695327;7545.811354716176;7547.320741133324;5184.092783762751;5249.816256431007;5364.7585858635675;5391.649542779707;5652.3217213934595;8800.207981281459;9164.6792362267;9191.816163676824;9295.6281748732;9394.81210375775;9296.767580810534;9301.534923253676;9354.345195836226;9495.572699228689;9512.09635084666;5709.514691251124;5907.261592300963;5907.85230369227;6441.903371449338;6612.669366531558;6883.070785443901;7275.34521893011;7595.126560445619;7672.5012874163;7809.960950195213;6849.1780986281965;6937.340952609494;6942.06282151903;6973.302669733189;7139.428845692229;6744;6762.763303284361;6792.83017924536;6846.897296540456;6878.105846240157;6501.804945851632;6529.183852018497;6567.540272180901;6576.605403675795;6638.90041649366;4533.478649955297;4636.11913736389;4662.5104364042645;4732.148213321498;4886.584640305614;4560.817567297271;4654.837080702159;4687.437507499122;4770.761461926821;4784.378030855966 21:32:28 INFO - PROCESS | 5399 | |4;prototype.html;281.45621267348577;292.800895391134;295.41507814527233;295.8535524915166;300.29880229663735;4672.369230153929;4805;4822.156122678535;4874.390701162359;4880.804767809288;4604.171249175147;4759.571638552529;4762.856914340559;4767.425590181298;4771.26045462953;3769.7172712046568;3780.395136778116;3784.791836448994;3785.6782173515217;3791.696664266866;3557.4485954677066;3790.6019867913888;3802;3805.0867791729925;3811;3590.35373632746;3742.7941463219513;3751.1184871555297;3755.2864955658474;3762.698984081267;3736.831842567091;3737.177820879402;3750.9624903750887;3750.9684836670135;3753.380692185786;3299.884504042347;3307.6361600223954;3316.5241467546953;3322.551455553518;3339.1985923378456;4531.957649740578;4704.270838020112;4704.952950470486;4717.339572459859;4719.764011799396;4321.438213032286;4321.567843215685;4321.978390108061;4323.848665296731;4326.718763280408;5008.84973450797;5045;5045.772940217699;5047.293378926953;5055.823046193365;3308.354870800195;3609.484016712987;3620.6379362063844;3623.7644553103964;3633.4368172932973;5199.272101905736;5259.737013149327;5260.553347829377;5266.894662106736;5268.236105764681;3597.2985267873037;3601.1537288737127;3602;3619.2580520993133;3626.165981824195;3650.8602601762464;3660.1581636223286;3670.6696397323835;3671.9265614687556;3679.6688298053305;4077.55146933837;4121.979390103031;4186.3092589722355;4189.476315460567;4210.389493523483;4979.701217926936;4987.351644286219;5017.767093643293;5025.522575355335;5042.268871013755;1178.5933852820763;1220.5727995201607;1246.956356527517;1264.525802823941;1266.3351740336213;838.1199740272812;850.1923172985688;853.7054716122927;856.8928883889514;857.8627419612957;4397.142557201379;4409.14021765759;4412.602865742098;4414.161309351213;4420.9336859947125;5150.613703972217;5166.03690597578;5172.612054095958;5174.353205849269;5177.197534382177;4218.261804184255;4413.44831896013;4450.265706158448;4495.752733599618;4513.73615387692;2759.434315965222;2775.8195717278313;2782.8191167574446;2785.846778427206;2789.595508651275;4852.883836717504;4877.853664390074;4878.9022469943975;4880.755962201875;4890;5185.611079169077;5256.342957130359;5330.9733451332495;5347.652402593897;5367.396812545912;4807.855764327076;4811.326414302001;4828.444728856156;4837.250226214942;4845.345878306383;4992.350994370709;5201;5211.426743058337;5213.244079608511;5216.556592689664;5068.847934561969;5086;5089;5096.51583099605;5105.923411148761;4828.672115168357;4831.975840120777;4844.588210002048;4845.733484658378;4859;3591.3894637911094;3597.226596281812;3605.008622628798;3608.837602307955;3610.981945090258;5023.723695196799;5129.461406552258;5171.379434467888;5197.194434862602;5216.426193118678;5016.172331565251;5019.974900125622;5033.823816166563;5040.57155141817;5041.495850414929;5006.374203224597;5011.4487406386;5015.793051057523;5032.018756342624;5062.822986116005;4706.929396058993;4817.542333478314;4877.951280449719;4992.975035124801;5054.21659642756;5024.824131155392;5025.221090730943;5112.520427592689;5118.97440512795;5129.128048231735;4923.975380123076;4945.629077819106;4980.551750342486;4996.575291100297;5003.374578177728 21:32:28 INFO - PROCESS | 5399 | |5;yui.html;606.3261018906621;658.8484648530838;690.2855544511432;705.277090981744;735.2977906099674;13581.456741730331;14390.1365918045;14440.783388249185;14456.638584035405;14505.129692218461;13090.214587124756;13253.006024548149;13253.801192982113;13269.734605307913;13308.600741977756;608.2062907905182;730.9159446663622;737.9446541509382;758.2493331601702;767.7044337929881;760.0613242645329;761.4251240313583;761.7410080572604;761.8552475029754;761.9009528761281;812.7074253268819;814.1085511365046;814.2061490047216;814.543855440952;814.861473549498;635.9427651511363;771.3828936850497;794.0986979777936;794.7258195922456;799.672134424883;577.1141298107427;579.0763731847696;579.5653260054959;579.8492391978074;580.0226618148433;13252.602421927357;13289.20264784116;13302.135361201492;13304.800427993589;13317.600471985856;12677.366131693378;12853.742925141445;12969.610911672666;13499.055066145374;13524.567650304829;11629.534818607246;11715.297082175097;11765.470553825098;11826.408679566073;12151.210171338835;4046.8583599574167;4047.898802529931;4069.267531844267;4071.7149799514045;4110.609492098246;51520.48479515194;52734.47265527334;53056.204156937674;53073;63486;10099.747506312255;11047.447627618747;11052.502637381338;11173;11417.600383986686;19676.311329103413;20454.284100056724;20672.48318792042;20761.169553217704;20792.1683132676;7057.964710176519;7180.533265337841;7229.89155162673;7322.780316590511;7502.287282708134;3705.81470926458;3713.0717320669833;3732.5894151643297;3743.6630703236838;3815.923681526354;2919.722626350493;3033.4691428999836;3040.2855328997666;3042.2242328206166;3044.4367791958557;535.4377903201623;546.1125670784975;569.0951387294222;582.624207386242;586.9383714709979;491.9631027672939;530.933633295838;591.9822405327847;603.5925750118653;612.8069658057698;7571.924280757122;7722;8030.39772017101;8808.20726134651;8883.289336853037;505.2698850161481;526.6497778977014;569.6582050769588;576.2278546747378;580.2369883603048;3906.3554513505524;4199.475065616798;4200.936985945214;4210.694684647769;4338.522762496123;57522.137167942514;71029.6448517754;91482;105126;105794.47102764591;89701;91103.54448227849;92412.53793731122;93389;93625.5318723402;45329.32006019913;46125;46436.5356346439;46681;47844;7742.341900938483;7931.5637639930355;8151.388645851466;8194.631241594261;8270.710525131832;38434;47049.29426058543;47190.76404617955;48418.273725893436;48915.266271005254;63533.36466635275;69656.6517167411;69956;70830;75827;10708.642637808409;10830.837537437103;10859.945700271765;10991.120710342993;11097.556097756322;11751;12047.879521205026;12696.936515317733;12700.682482938;12794.232346059267;10855;11361.37512436824;11501.367424791717;11856.822147667965;12016.879831201577;10802.567897284021;10999.505022274177;11255.324680518868;11784.646460606196;12154.209976351509;10874;11019.83470247931;11197;11720.824187637021;11723.120765942758;8794.252488538546;8915.73252802417;9001.36990410665;9308.348415610842;9425.104615061558;8890.288776897962;8890.64437422496;9442.38624489406;9466.337356385262;9683 21:32:28 INFO - PROCESS | 5399 | __end_tp_report 21:32:28 INFO - PROCESS | 5399 | __start_cc_report 21:32:28 INFO - PROCESS | 5399 | _x_x_mozilla_cycle_collect,1206 21:32:28 INFO - PROCESS | 5399 | __end_cc_report 21:32:28 INFO - PROCESS | 5399 | __startTimestamp1472185948605__endTimestamp 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | ------- Summary: start ------- 21:32:28 INFO - PROCESS | 5399 | Number of tests: 6 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | [#0] dojo.html Cycles:165 Average:4683.20 Median:4800.78 stddev:503.10 (10.5%) stddev-sans-first:475.81 21:32:28 INFO - PROCESS | 5399 | Values: 2543.1 2554.7 2579.9 2584.0 2603.3 4575.8 4635.3 4640.0 4719.7 4788.8 4720.2 4741.9 4767.5 4775.5 4800.8 4297.2 4313.4 4387.0 4458.8 4520.7 4416.1 4469.9 4479.4 4497.5 4522.6 4253.3 4299.6 4301.1 4357.9 4387.0 4307.1 4334.5 4365.5 4380.4 4415.7 4334.0 4395.5 4400.6 4404.7 4458.2 4742.2 4791.4 4796.1 4801.5 4862.0 4954.1 5004.4 5050.2 5072.2 5089.8 5089.6 5090.7 5102.0 5104.8 5128.9 4629.1 4752.8 4755.0 4757.1 4802.3 5179.4 5234.3 5239.7 5247.3 5317.8 5020.6 5026.7 5029.3 5031.4 5091.0 4897.3 5111.0 5121.3 5122.7 5132.1 4927.5 4961.5 4989.1 5028.1 5064.2 4928.3 4942.9 4947.5 4950.1 5022.0 4198.8 4201.7 4203.6 4208.5 4252.9 3642.0 3644.8 3669.9 3728.0 3740.0 4409.5 4410.8 4454.1 4462.2 4466.1 5094.8 5127.9 5135.0 5139.0 5140.8 4271.6 4337.4 4378.0 4404.8 4453.1 4548.6 4576.3 4611.0 4626.0 4629.5 4730.0 4731.1 4731.3 4734.6 4791.2 4931.9 5067.2 5073.6 5097.7 5100.8 4705.0 4730.6 4735.3 4774.4 4785.0 5025.8 5027.1 5029.5 5040.3 5079.4 4974.8 5022.9 5025.7 5103.1 5186.5 4845.8 4877.8 4918.3 4941.7 4991.1 4922.7 4927.7 4930.7 4933.5 4992.5 4842.6 4866.8 4867.9 4870.9 4927.1 4794.7 4897.9 4900.6 4949.7 5036.4 4851.0 4859.2 4861.5 4865.1 4927.4 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | [#1] ext.html Cycles:180 Average:45667.67 Median:35735.37 stddev:82287.03 (230.3%) stddev-sans-first:82448.15 21:32:28 INFO - PROCESS | 5399 | Values: 553.4 558.5 577.4 580.9 583.5 28254.9 39039.8 40485.6 40555.8 44174.3 40825.8 41324.6 41331.0 41374.0 41390.4 7649.1 7790.5 7804.5 7807.3 7809.5 7293.1 9654.1 9853.8 9863.2 10156.5 10051.7 10066.7 10084.9 10137.3 10153.7 9936.3 9971.7 10003.6 10006.9 10014.8 9478.4 9561.7 9561.8 9578.2 9583.4 37944.8 38237.6 38248.0 38248.4 38295.2 3037.1 3047.6 3066.2 3091.1 3118.3 28905.3 29389.3 29719.4 29796.4 29866.0 3343.0 3354.2 3384.5 3542.1 3551.3 255090.0 255777.0 256291.0 256665.0 257567.0 32708.3 53108.7 53655.0 53658.0 53721.0 33272.2 33470.0 33492.0 33497.2 33497.3 12364.2 12489.0 12494.7 12497.4 12508.4 9385.7 9767.0 9822.7 9834.4 10044.7 7620.4 7711.6 7805.8 7825.1 7825.6 3039.8 3053.9 3070.7 3078.3 3084.3 857.5 867.8 870.0 894.2 937.9 27758.7 28006.7 28159.0 28491.9 28588.9 900.4 915.8 943.9 955.8 961.2 14436.8 14833.3 15016.9 15122.9 15300.0 378741.0 379617.0 380955.0 381715.0 384095.0 48954.8 49503.8 49567.0 49600.5 49631.0 1031.8 1136.5 1155.4 1173.1 1179.6 25733.4 28216.0 28780.6 29292.7 29667.0 42295.8 42694.8 42777.8 42818.0 42825.4 286253.0 286790.0 286924.0 287272.0 287939.0 24525.5 25853.5 25905.5 26928.2 27003.2 40963.2 41334.0 41778.6 42971.0 47203.3 36101.6 36327.3 36425.6 36429.5 36932.8 35296.6 35382.8 36125.6 36188.6 38085.8 35256.6 35549.5 35921.3 35967.3 36025.6 30964.5 32969.5 33484.2 33911.5 34025.8 25302.4 25462.9 25606.7 25673.4 25679.5 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | [#2] jquery.html Cycles:180 Average:24479.26 Median:5072.35 stddev:65412.76 (1289.6%) stddev-sans-first:65571.14 21:32:28 INFO - PROCESS | 5399 | Values: 335.8 353.7 365.5 369.1 379.7 12434.0 15823.8 15941.8 17095.4 17260.8 16397.7 16642.3 16905.8 17035.9 17059.7 5008.6 5039.7 5075.0 5145.5 5165.1 3636.9 5117.5 5127.9 5722.2 6028.3 5992.5 5999.3 6015.9 6030.5 6035.0 5069.7 5295.1 5325.1 5407.8 6034.9 5224.9 5235.5 5238.5 5238.9 5245.7 11922.8 12177.0 12188.3 12257.9 12695.0 1844.8 1861.4 1974.8 2120.0 2212.7 8866.0 9217.1 9227.6 11925.3 12165.8 1699.7 1719.4 1766.5 1782.4 1795.7 66597.8 69546.2 70525.3 71438.0 72240.0 9684.3 9871.2 10014.9 10222.9 10296.4 13733.5 13738.7 13739.3 13758.9 13771.4 6751.9 7109.3 7120.6 7260.4 7302.9 6633.9 6681.5 6878.3 6889.3 6953.3 4201.0 4243.1 4292.2 4338.2 4461.8 1656.9 1686.2 1702.2 1729.5 1739.5 799.9 855.2 865.9 889.3 927.9 15818.8 16157.0 16291.7 16453.8 17079.4 852.2 859.9 891.1 893.3 902.1 8798.6 9384.0 9447.4 9452.0 9572.3 390065.0 390778.0 394109.0 398944.0 400622.0 77962.6 80348.0 80403.0 80430.6 83263.6 855.8 914.7 916.2 917.4 938.0 14997.6 15252.1 15352.9 15743.4 16033.5 39769.8 39902.6 40268.8 40819.2 41610.4 55086.2 56052.2 56115.0 57148.7 57625.0 6442.2 7506.3 7509.8 7555.2 7609.5 8730.6 10916.0 10921.6 10981.7 11140.4 9073.9 9672.3 9745.8 9767.0 10309.7 10344.8 10543.5 10571.2 10645.3 11011.7 10205.6 10215.8 10307.9 10352.8 10624.9 6366.4 7316.6 7488.0 7552.9 7592.9 8195.8 9442.3 9822.6 10105.2 10152.8 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | [#3] mootools.html Cycles:180 Average:5187.50 Median:5378.20 stddev:2961.85 (55.1%) stddev-sans-first:2955.12 21:32:28 INFO - PROCESS | 5399 | Values: 1216.6 1325.4 1368.9 1436.8 1668.9 6500.7 7782.9 8037.8 8038.6 8227.1 8039.2 8115.6 8117.3 8120.0 8133.7 2151.3 2176.6 2178.5 2179.1 2179.4 2130.8 2169.1 2206.1 2208.5 2216.4 1901.3 1914.3 1929.6 1935.9 1965.2 2136.2 2146.9 2147.2 2149.2 2159.2 2065.3 2137.7 2140.3 2150.6 2162.5 7733.1 7995.2 8016.4 8082.4 8101.1 4449.8 4602.9 4603.0 4605.6 4640.4 2854.9 2973.2 3043.0 3046.0 3052.2 984.2 987.2 1001.8 1008.3 1012.8 10823.0 10931.3 10937.7 10940.7 10948.5 4040.4 4292.3 4487.9 4505.3 4509.3 8568.9 8642.7 8645.3 8647.3 8649.3 4515.1 4522.1 4524.7 4525.5 4527.5 3600.3 3974.4 4018.9 4225.8 4229.4 3416.3 3455.6 3501.0 3525.5 3575.2 924.7 932.1 933.4 936.1 936.5 801.7 828.0 829.7 836.4 840.5 5276.9 5392.2 5428.7 5483.9 5595.6 822.9 855.8 862.1 878.7 900.4 3666.7 3821.1 3823.9 3838.6 3939.5 9554.1 9836.4 9991.6 10040.1 10060.8 9990.8 9993.1 9999.5 10001.2 10002.7 7287.7 7448.1 7541.5 7545.8 7547.3 5184.1 5249.8 5364.8 5391.6 5652.3 8800.2 9164.7 9191.8 9295.6 9394.8 9296.8 9301.5 9354.3 9495.6 9512.1 5709.5 5907.3 5907.9 6441.9 6612.7 6883.1 7275.3 7595.1 7672.5 7810.0 6849.2 6937.3 6942.1 6973.3 7139.4 6744.0 6762.8 6792.8 6846.9 6878.1 6501.8 6529.2 6567.5 6576.6 6638.9 4533.5 4636.1 4662.5 4732.1 4886.6 4560.8 4654.8 4687.4 4770.8 4784.4 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | [#4] prototype.html Cycles:180 Average:4171.06 Median:4769.34 stddev:1217.32 (25.5%) stddev-sans-first:1185.21 21:32:28 INFO - PROCESS | 5399 | Values: 281.5 292.8 295.4 295.9 300.3 4672.4 4805.0 4822.2 4874.4 4880.8 4604.2 4759.6 4762.9 4767.4 4771.3 3769.7 3780.4 3784.8 3785.7 3791.7 3557.4 3790.6 3802.0 3805.1 3811.0 3590.4 3742.8 3751.1 3755.3 3762.7 3736.8 3737.2 3751.0 3751.0 3753.4 3299.9 3307.6 3316.5 3322.6 3339.2 4532.0 4704.3 4705.0 4717.3 4719.8 4321.4 4321.6 4322.0 4323.8 4326.7 5008.8 5045.0 5045.8 5047.3 5055.8 3308.4 3609.5 3620.6 3623.8 3633.4 5199.3 5259.7 5260.6 5266.9 5268.2 3597.3 3601.2 3602.0 3619.3 3626.2 3650.9 3660.2 3670.7 3671.9 3679.7 4077.6 4122.0 4186.3 4189.5 4210.4 4979.7 4987.4 5017.8 5025.5 5042.3 1178.6 1220.6 1247.0 1264.5 1266.3 838.1 850.2 853.7 856.9 857.9 4397.1 4409.1 4412.6 4414.2 4420.9 5150.6 5166.0 5172.6 5174.4 5177.2 4218.3 4413.4 4450.3 4495.8 4513.7 2759.4 2775.8 2782.8 2785.8 2789.6 4852.9 4877.9 4878.9 4880.8 4890.0 5185.6 5256.3 5331.0 5347.7 5367.4 4807.9 4811.3 4828.4 4837.3 4845.3 4992.4 5201.0 5211.4 5213.2 5216.6 5068.8 5086.0 5089.0 5096.5 5105.9 4828.7 4832.0 4844.6 4845.7 4859.0 3591.4 3597.2 3605.0 3608.8 3611.0 5023.7 5129.5 5171.4 5197.2 5216.4 5016.2 5020.0 5033.8 5040.6 5041.5 5006.4 5011.4 5015.8 5032.0 5062.8 4706.9 4817.5 4878.0 4993.0 5054.2 5024.8 5025.2 5112.5 5119.0 5129.1 4924.0 4945.6 4980.6 4996.6 5003.4 21:32:28 INFO - PROCESS | 5399 | 21:32:28 INFO - PROCESS | 5399 | [#5] yui.html Cycles:180 Average:17028.04 Median:48666.77 stddev:23951.23 (49.2%) stddev-sans-first:23986.68 21:32:28 INFO - PROCESS | 5399 | Values: 606.3 658.8 690.3 705.3 735.3 13581.5 14390.1 14440.8 14456.6 14505.1 13090.2 13253.0 13253.8 13269.7 13308.6 608.2 730.9 737.9 758.2 767.7 760.1 761.4 761.7 761.9 761.9 812.7 814.1 814.2 814.5 814.9 635.9 771.4 794.1 794.7 799.7 577.1 579.1 579.6 579.8 580.0 13252.6 13289.2 13302.1 13304.8 13317.6 12677.4 12853.7 12969.6 13499.1 13524.6 11629.5 11715.3 11765.5 11826.4 12151.2 4046.9 4047.9 4069.3 4071.7 4110.6 51520.5 52734.5 53056.2 53073.0 63486.0 10099.7 11047.4 11052.5 11173.0 11417.6 19676.3 20454.3 20672.5 20761.2 20792.2 7058.0 7180.5 7229.9 7322.8 7502.3 3705.8 3713.1 3732.6 3743.7 3815.9 2919.7 3033.5 3040.3 3042.2 3044.4 535.4 546.1 569.1 582.6 586.9 492.0 530.9 592.0 603.6 612.8 7571.9 7722.0 8030.4 8808.2 8883.3 505.3 526.6 569.7 576.2 580.2 3906.4 4199.5 4200.9 4210.7 4338.5 57522.1 71029.6 91482.0 105126.0 105794.5 89701.0 91103.5 92412.5 93389.0 93625.5 45329.3 46125.0 46436.5 46681.0 47844.0 7742.3 7931.6 8151.4 8194.6 8270.7 38434.0 47049.3 47190.8 48418.3 48915.3 63533.4 69656.7 69956.0 70830.0 75827.0 10708.6 10830.8 10859.9 10991.1 11097.6 11751.0 12047.9 12696.9 12700.7 12794.2 10855.0 11361.4 11501.4 11856.8 12016.9 10802.6 10999.5 11255.3 11784.6 12154.2 10874.0 11019.8 11197.0 11720.8 11723.1 8794.3 8915.7 9001.4 9308.3 9425.1 8890.3 8890.6 9442.4 9466.3 9683.0 21:32:28 INFO - PROCESS | 5399 | -------- Summary: end -------- 21:32:28 INFO - PROCESS | 5399 | 21:32:29 INFO - TEST-INFO | 5399: exit 0 21:32:29 INFO - TEST-OK | dromaeo_css | took 1122376ms 21:32:29 INFO - TEST-START | kraken 21:32:29 INFO - operating with platform_type : linux_ 21:32:29 INFO - Initialising browser for kraken test... 21:32:29 INFO - TEST-INFO | started process 5709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4uUL2/profile http://localhost:52130/getInfo.html) 21:32:34 INFO - PROCESS | 5709 | __metrics Screen width/height:1600/1200 21:32:34 INFO - PROCESS | 5709 | colorDepth:24 21:32:34 INFO - PROCESS | 5709 | Browser inner width/height: 1024/697 21:32:34 INFO - PROCESS | 5709 | __metrics 21:32:35 INFO - PROCESS | 5709 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:32:35 INFO - PROCESS | 5709 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:32:36 INFO - PROCESS | 5709 | console.error: PushService: 21:32:36 INFO - PROCESS | 5709 | stateChangeProcessEnqueue: Error transitioning state 21:32:36 INFO - PROCESS | 5709 | UnknownError 21:32:36 INFO - TEST-INFO | 5709: exit 0 21:32:36 INFO - Browser initialized. 21:32:36 INFO - Running cycle 1/1 for kraken test... 21:32:36 INFO - TEST-INFO | started process 5790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4uUL2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:32:48 INFO - PROCESS | 5790 | RSS: Main: 181895168 21:32:48 INFO - PROCESS | 5790 | 21:32:51 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52130/tests/kraken/driver.html?testName=audio-beat-detection) 21:32:52 INFO - PROCESS | 5790 | RSS: Main: 234553344 21:32:52 INFO - PROCESS | 5790 | 21:32:55 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52130/tests/kraken/driver.html?testName=audio-dft) 21:32:55 INFO - PROCESS | 5790 | RSS: Main: 225480704 21:32:55 INFO - PROCESS | 5790 | 21:32:59 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52130/tests/kraken/driver.html?testName=audio-fft) 21:32:59 INFO - PROCESS | 5790 | RSS: Main: 303501312 21:32:59 INFO - PROCESS | 5790 | 21:33:02 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52130/tests/kraken/driver.html?testName=audio-oscillator) 21:33:02 INFO - PROCESS | 5790 | RSS: Main: 213315584 21:33:02 INFO - PROCESS | 5790 | 21:33:04 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52130/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:33:05 INFO - PROCESS | 5790 | RSS: Main: 215232512 21:33:05 INFO - PROCESS | 5790 | 21:33:08 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52130/tests/kraken/driver.html?testName=imaging-darkroom) 21:33:09 INFO - PROCESS | 5790 | RSS: Main: 253992960 21:33:09 INFO - PROCESS | 5790 | 21:33:12 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52130/tests/kraken/driver.html?testName=imaging-desaturate) 21:33:13 INFO - PROCESS | 5790 | RSS: Main: 252592128 21:33:13 INFO - PROCESS | 5790 | 21:33:16 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52130/tests/kraken/driver.html?testName=json-parse-financial) 21:33:16 INFO - PROCESS | 5790 | RSS: Main: 252555264 21:33:16 INFO - PROCESS | 5790 | 21:33:18 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52130/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:33:19 INFO - PROCESS | 5790 | RSS: Main: 215293952 21:33:19 INFO - PROCESS | 5790 | 21:33:21 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:33:21 INFO - PROCESS | 5790 | RSS: Main: 222580736 21:33:21 INFO - PROCESS | 5790 | 21:33:23 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:33:24 INFO - PROCESS | 5790 | RSS: Main: 223485952 21:33:24 INFO - PROCESS | 5790 | 21:33:27 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:33:27 INFO - PROCESS | 5790 | RSS: Main: 224968704 21:33:27 INFO - PROCESS | 5790 | 21:33:30 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:33:31 INFO - PROCESS | 5790 | RSS: Main: 222339072 21:33:31 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | Cycle 1(1): loaded http://localhost:52130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52130/tests/kraken/driver.html?testName=ai-astar) 21:33:33 INFO - PROCESS | 5790 | RSS: Main: 273727488 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | __start_tp_report 21:33:33 INFO - PROCESS | 5790 | _x_x_mozilla_page_load 21:33:33 INFO - PROCESS | 5790 | _x_x_mozilla_page_load_details 21:33:33 INFO - PROCESS | 5790 | |i|pagename|runs| 21:33:33 INFO - PROCESS | 5790 | |0;ai-astar;117;117;133;117;114;118;114;114;115;113 21:33:33 INFO - PROCESS | 5790 | |1;audio-beat-detection;162;124;147;185;123;153;151;126;181;124 21:33:33 INFO - PROCESS | 5790 | |2;audio-dft;159;163;162;160;162;160;162;161;162;160 21:33:33 INFO - PROCESS | 5790 | |3;audio-fft;75;75;77;180;77;76;80;78;165;77 21:33:33 INFO - PROCESS | 5790 | |4;audio-oscillator;91;84;137;84;84;84;134;83;82;133 21:33:33 INFO - PROCESS | 5790 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 21:33:33 INFO - PROCESS | 5790 | |6;imaging-darkroom;145;147;146;147;147;146;146;146;146;146 21:33:33 INFO - PROCESS | 5790 | |7;imaging-desaturate;95;95;95;94;94;95;96;95;95;94 21:33:33 INFO - PROCESS | 5790 | |8;json-parse-financial;62;63;62;64;62;63;64;66;62;61 21:33:33 INFO - PROCESS | 5790 | |9;json-stringify-tinderbox;66;65;66;66;67;65;65;66;66;65 21:33:33 INFO - PROCESS | 5790 | |10;stanford-crypto-aes;83;83;81;85;91;81;84;82;82;82 21:33:33 INFO - PROCESS | 5790 | |11;stanford-crypto-ccm;134;133;130;145;139;140;141;142;174;141 21:33:33 INFO - PROCESS | 5790 | |12;stanford-crypto-pbkdf2;179;173;172;175;173;173;172;175;173;172 21:33:33 INFO - PROCESS | 5790 | |13;stanford-crypto-sha256-iterative;69;68;70;68;68;69;68;70;68;69 21:33:33 INFO - PROCESS | 5790 | __end_tp_report 21:33:33 INFO - PROCESS | 5790 | __start_cc_report 21:33:33 INFO - PROCESS | 5790 | _x_x_mozilla_cycle_collect,2017 21:33:33 INFO - PROCESS | 5790 | __end_cc_report 21:33:33 INFO - PROCESS | 5790 | __startTimestamp1472186013545__endTimestamp 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | ------- Summary: start ------- 21:33:33 INFO - PROCESS | 5790 | Number of tests: 14 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#0] ai-astar Cycles:10 Average:117.20 Median:117.00 stddev:5.81 (5.0%) stddev-sans-first:6.16 21:33:33 INFO - PROCESS | 5790 | Values: 117.0 117.0 133.0 117.0 114.0 118.0 114.0 114.0 115.0 113.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.00 stddev:23.45 (15.4%) stddev-sans-first:24.28 21:33:33 INFO - PROCESS | 5790 | Values: 162.0 124.0 147.0 185.0 123.0 153.0 151.0 126.0 181.0 124.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 21:33:33 INFO - PROCESS | 5790 | Values: 159.0 163.0 162.0 160.0 162.0 160.0 162.0 161.0 162.0 160.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#3] audio-fft Cycles:10 Average:96.00 Median:77.00 stddev:40.50 (52.6%) stddev-sans-first:42.24 21:33:33 INFO - PROCESS | 5790 | Values: 75.0 75.0 77.0 180.0 77.0 76.0 80.0 78.0 165.0 77.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:84.00 stddev:24.34 (29.0%) stddev-sans-first:25.61 21:33:33 INFO - PROCESS | 5790 | Values: 91.0 84.0 137.0 84.0 84.0 84.0 134.0 83.0 82.0 133.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:33:33 INFO - PROCESS | 5790 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 21:33:33 INFO - PROCESS | 5790 | Values: 145.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:33:33 INFO - PROCESS | 5790 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 95.0 94.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.50 21:33:33 INFO - PROCESS | 5790 | Values: 62.0 63.0 62.0 64.0 62.0 63.0 64.0 66.0 62.0 61.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 21:33:33 INFO - PROCESS | 5790 | Values: 66.0 65.0 66.0 66.0 67.0 65.0 65.0 66.0 66.0 65.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.95 (3.6%) stddev-sans-first:3.13 21:33:33 INFO - PROCESS | 5790 | Values: 83.0 83.0 81.0 85.0 91.0 81.0 84.0 82.0 82.0 82.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:141.00 stddev:12.19 (8.6%) stddev-sans-first:12.59 21:33:33 INFO - PROCESS | 5790 | Values: 134.0 133.0 130.0 145.0 139.0 140.0 141.0 142.0 174.0 141.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:173.00 stddev:2.16 (1.3%) stddev-sans-first:1.17 21:33:33 INFO - PROCESS | 5790 | Values: 179.0 173.0 172.0 175.0 173.0 173.0 172.0 175.0 173.0 172.0 21:33:33 INFO - PROCESS | 5790 | 21:33:33 INFO - PROCESS | 5790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 21:33:33 INFO - PROCESS | 5790 | Values: 69.0 68.0 70.0 68.0 68.0 69.0 68.0 70.0 68.0 69.0 21:33:33 INFO - PROCESS | 5790 | -------- Summary: end -------- 21:33:33 INFO - PROCESS | 5790 | 21:33:34 INFO - TEST-INFO | 5790: exit 0 21:33:34 INFO - TEST-OK | kraken | took 65291ms 21:33:34 INFO - SUITE-END | took 1187s 21:33:35 INFO - Completed test suite (00:19:47) 21:33:35 INFO - javascript benchmark 21:33:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2543.071778800738, 2554.655121558589, 2579.8839052242647, 2584.0, 2603.3101228174523, 4575.794089265983, 4635.281531362636, 4640.0, 4719.693219940706, 4788.760561971901, 4720.221163508017, 4741.90516189676, 4767.523247675231, 4775.522447755223, 4800.783964721579, 4297.205017071836, 4313.396124542551, 4387.0, 4458.754768487732, 4520.683552151334, 4416.094700586372, 4469.932951005738, 4479.372887795711, 4497.505274419827, 4522.592966633002, 4253.2769429197115, 4299.570042995707, 4301.0537681709975, 4357.869263922055, 4386.978065109686, 4307.095509942916, 4334.45819272591, 4365.476142862845, 4380.408644832939, 4415.690901636886, 4333.978330108361, 4395.472543294825, 4400.6259467945265, 4404.66964977628, 4458.175237581057, 4742.217534106868, 4791.425028996543, 4796.064767370364, 4801.5438533339275, 4862.027594481083, 4954.108260513106, 5004.449510553836, 5050.191969284897, 5072.2391641253735, 5089.847304580869, 5089.618278629081, 5090.720010399426, 5102.030614183293, 5104.821331253388, 5128.871778205537, 4629.074185162981, 4752.7623618818925, 4755.0, 4757.09615173116, 4802.303665968415, 5179.378474582999, 5234.293370395024, 5239.711815850089, 5247.2653828464045, 5317.760700768475, 5020.5732512736095, 5026.74866256693, 5029.2958985742025, 5031.396232452056, 5090.974545127251, 4897.338859253955, 5110.974445127825, 5121.308623335876, 5122.692638441706, 5132.0762262792305, 4927.482614325444, 4961.479044700327, 4989.077020751172, 5028.069807085701, 5064.164412871909, 4928.334674818925, 4942.901141977212, 4947.455779864212, 4950.059488697136, 5021.974890125526, 4198.832046718158, 4201.70588058833, 4203.62167404935, 4208.516020657602, 4252.851150209728, 3641.9817900910325, 3644.817759112034, 3669.889903302905, 3728.0, 3740.0275928258848, 4409.470863496401, 4410.80151393188, 4454.10917816438, 4462.152191083748, 4466.0844526871915, 5094.796208151706, 5127.948720512822, 5134.974325128351, 5138.97430512845, 5140.768665410065, 4271.551487093872, 4337.436133302651, 4377.956220437755, 4404.823807047746, 4453.087117140978, 4548.636109111263, 4576.26779715244, 4610.953890461053, 4625.95374046262, 4629.4676112247525, 4730.0, 4731.101090792738, 4731.33761273422, 4734.644901632322, 4791.209450440639, 4931.926021109614, 5067.189249720027, 5073.568746656428, 5097.6941383517105, 5100.79596816138, 4704.9529504704515, 4730.6215502759005, 4735.313379560013, 4774.379330687128, 4785.0, 5025.84922452327, 5027.145385284437, 5029.4719054498755, 5040.269160971565, 5079.390473143247, 4974.825881094289, 5022.874428139179, 5025.74871256443, 5103.081445339874, 5186.507281808223, 4845.830395936126, 4877.829275975324, 4918.2622606607865, 4941.703497790144, 4991.051700176955, 4922.704637721748, 4927.704337739747, 4930.704157750403, 4933.457319694902, 4992.450830408725, 4842.58837998774, 4866.78099485531, 4867.853964381075, 4870.902581948412, 4927.088488629615, 4794.736289504111, 4897.926531101965, 4900.583450406755, 4949.703017818798, 5036.445990941067, 4850.95149048505, 4859.222524396079, 4861.51384861511, 4865.0756356292195, 4927.384076990376], "value": 4649.701574882352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3719228675453, 558.5447859994102, 577.3591313641859, 580.895438821012, 583.5185971573452, 28254.85872570637, 39039.804800976024, 40485.59514404855, 40555.79722101389, 44174.33738493925, 40825.7958710206, 41324.58675413245, 41331.0, 41374.0, 41390.37914431286, 7649.08211014679, 7790.493617914845, 7804.453688241825, 7807.336376408012, 7809.531428114331, 7293.051903252596, 9654.13112819846, 9853.753656158582, 9863.161631261351, 10156.492175391239, 10051.748706282327, 10066.697999060003, 10084.949575252114, 10137.341072830279, 10153.695389138338, 9936.254780891426, 9971.70084897447, 10003.649872254437, 10006.949965250127, 10014.799704005953, 9478.38390504615, 9561.665341713076, 9561.808763824754, 9578.185854202331, 9583.377080489816, 37944.81027594872, 38237.61762382368, 38248.0, 38248.42627360592, 38295.234095318214, 3037.0888733379898, 3047.588575542318, 3066.156806878104, 3091.0881290019497, 3118.3139709263924, 28905.29457863507, 29389.265268368246, 29719.405611887858, 29796.40407191844, 29866.0, 3342.9832850835833, 3354.194993201614, 3384.509246159293, 3542.096765324826, 3551.3252482028333, 255090.0, 255777.0, 256291.0, 256665.0, 257567.0, 32708.345833083204, 53108.734456328246, 53655.0, 53658.0, 53721.0, 33272.1681957953, 33470.0, 33492.0, 33497.162570935434, 33497.33005339928, 12364.1963272387, 12489.0, 12494.687632809253, 12497.437615307334, 12508.437120329607, 9385.718428447157, 9767.0, 9822.65620703272, 9834.409935403899, 10044.748881278027, 7620.428467864932, 7711.575863327571, 7805.843883122306, 7825.13923468418, 7825.647845846951, 3039.8480075996113, 3053.92365190872, 3070.7082827131385, 3078.338157296192, 3084.3214492811544, 857.511218605389, 867.7613656244583, 870.0, 894.2309613732185, 937.8874535055837, 27758.722412775613, 28006.719932800817, 28159.0, 28491.85754071258, 28588.857055714587, 900.4372267332917, 915.8214148241162, 943.9103285187896, 955.7562821480478, 961.240619910277, 14436.783448248285, 14833.332500037308, 15016.924915375354, 15122.924385378003, 15300.0, 378741.0, 379617.0, 380955.0, 381715.0, 384095.0, 48954.75522622364, 49503.75248123809, 49567.034637228935, 49600.50399495959, 49631.0, 1031.798799234157, 1136.4601814138384, 1155.439611788282, 1173.137743758354, 1179.598936361641, 25733.3566660835, 28216.0, 28780.568291475225, 29292.707072929, 29667.0, 42295.7885210572, 42694.78652606717, 42777.78611106925, 42818.0, 42825.357619635106, 286253.0, 286790.0, 286924.0, 287272.0, 287939.0, 24525.50948981046, 25853.482930341663, 25905.48189036171, 26928.192154235403, 27003.1899043029, 40963.18546284986, 41334.0, 41778.58221417747, 42971.0, 47203.29195062008, 36101.638983609824, 36327.27345453129, 36425.63574364328, 36429.45355819612, 36932.81533592422, 35296.64703353036, 35382.8230858844, 36125.638743612224, 36188.63811361958, 38085.80957095197, 35256.64743352636, 35549.46675799813, 35921.28157436889, 35967.28065438729, 36025.63974360328, 30964.535531966587, 32969.505457417676, 33484.162895927795, 33911.491327630596, 34025.82987085049, 25302.367440814127, 25462.872685636452, 25606.743932560435, 25673.442857213562, 25679.486410272064], "value": 16714.539536793494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.77503072941124, 353.690520794305, 365.48831635710013, 369.12149085177276, 379.73798079325263, 12434.0, 15823.762643560342, 15941.76087358689, 17095.40166094187, 17260.827391726078, 16397.672046559062, 16642.25109870056, 16905.83094169058, 17035.91482042591, 17059.658806823856, 5008.649394542384, 5039.748012599373, 5074.974625126869, 5145.485451454862, 5165.147750621162, 3636.945445818315, 5117.462666420028, 5127.897442051157, 5722.170285308628, 6028.336882942873, 5992.460678538931, 5999.340072592033, 6015.939840601582, 6030.487408570277, 6034.969825150868, 5069.721165335886, 5295.126304159809, 5325.094733895247, 5407.783688652449, 6034.883546543903, 5224.947750522522, 5235.528802407764, 5238.528532432061, 5238.8690282742855, 5245.6852588844795, 11922.821157682554, 12177.0, 12188.268703877795, 12257.877421225763, 12695.0, 1844.787849397323, 1861.4136546987656, 1974.7827738948704, 2119.9682004769943, 2212.6570381590877, 8866.0, 9217.078292170729, 9227.584758685874, 11925.344106074162, 12165.756684866341, 1699.7110491216522, 1719.3810228317795, 1766.5495298698877, 1782.4047477507559, 1795.7429799140523, 66597.79408095033, 69546.17496037716, 70525.2947470529, 71438.0, 72240.0, 9684.273679474067, 9871.210303175729, 10014.949925250472, 10222.948885255526, 10296.433696146634, 13733.519326823513, 13738.725225495435, 13739.313034348243, 13758.93120534411, 13771.449142034407, 6751.864962700817, 7109.324614161646, 7120.572765633975, 7260.41916646667, 7302.926970730331, 6633.86732265352, 6681.516671758963, 6878.34655707717, 6889.311068893071, 6953.269906659829, 4201.0, 4243.130158317537, 4292.163028209469, 4338.175746608197, 4461.7992190351515, 1656.8923020003901, 1686.232764092335, 1702.1914590569381, 1729.5157355940357, 1739.5477175934348, 799.8960135182389, 855.170484629908, 865.9004214515286, 889.3463304471209, 927.8515437529962, 15818.841811581737, 16157.0, 16291.674166516603, 16453.83546164523, 17079.413323202018, 852.194676031157, 859.9011113722003, 891.1266958380694, 893.2809088683542, 902.1474706402518, 8798.560071996375, 9384.0, 9447.433154010781, 9452.0, 9572.32993690435, 390065.0, 390778.0, 394109.0, 398944.0, 400622.0, 77962.61018694984, 80348.0, 80403.0, 80430.59784701157, 83263.5836820812, 855.7603870916154, 914.6707185413246, 916.2486760856034, 917.3945196170496, 937.9624815007323, 14997.550073497376, 15252.084874907541, 15352.923235383752, 15743.44897928567, 16033.518994430186, 39769.80115099406, 39902.60097398989, 40268.79865600653, 40819.183616328104, 41610.37584436296, 55086.17370739362, 56052.159217610955, 56115.0, 57148.71425642845, 57625.0, 6442.162518872704, 7506.3244308012545, 7509.774706758806, 7555.168931417649, 7609.467337286337, 8730.607122679621, 10916.0, 10921.576761411641, 10981.670549883516, 11140.387278699425, 9073.863892041492, 9672.322937394596, 9745.756356091155, 9766.951165244129, 10309.74225644365, 10344.844827327446, 10543.525541350811, 10571.207159463225, 10645.308054976402, 11011.73365063028, 10205.642802501878, 10215.795684086128, 10307.896921030993, 10352.792944140925, 10624.946875265574, 6366.395192456709, 7316.597587132546, 7487.962560187382, 7552.886706699294, 7592.924070759222, 8195.83608327842, 9442.339036267394, 9822.557984890555, 10105.24210684187, 10152.847707284544], "value": 8067.47939688447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.6046035038614, 1325.3969443903025, 1368.931553422329, 1436.7701167813145, 1668.8915220510667, 6500.739970401184, 7782.922170778291, 8037.839243215132, 8038.6382612782345, 8227.05388880279, 8039.196080391973, 8115.63479643416, 8117.310028647572, 8120.025596928362, 8133.715319963802, 2151.300827231148, 2176.5864485747657, 2178.5316157026236, 2179.052112331141, 2179.4333473296897, 2130.7656157822626, 2169.123707992583, 2206.1175529788134, 2208.4810069633622, 2216.412650647572, 1901.334532913476, 1914.339552854263, 1929.6140771845617, 1935.874168179071, 1965.2335589120255, 2136.2309568555384, 2146.9355919322447, 2147.2162660628915, 2149.2370208575967, 2159.2118876609925, 2065.349414934291, 2137.732783402075, 2140.3364956863265, 2150.602138604363, 2162.535054963175, 7733.110692270405, 7995.240452157036, 8016.398770092266, 8082.353411727047, 8101.108878023413, 4449.822007119711, 4602.930956035662, 4602.953970460319, 4605.608523275526, 4640.396748422717, 2854.942901141986, 2973.152651494314, 3043.04144194578, 3045.9695403045907, 3052.222477545445, 984.2273815055147, 987.1954357198932, 1001.7645853224486, 1008.3193844155165, 1012.7873146639215, 10823.02592766647, 10931.289466184673, 10937.671869843918, 10940.726481837939, 10948.507317170746, 4040.4141399496907, 4292.334688123346, 4487.88780280489, 4505.324201369821, 4509.301058335963, 8568.871466928002, 8642.740717778477, 8645.308375329958, 8647.26498247656, 8649.308055355556, 4515.1195516873895, 4522.072975040109, 4524.7285162889675, 4525.52481989393, 4527.524609915978, 3600.3339382214376, 3974.423708562242, 4018.9196216075516, 4225.7887105644595, 4229.407882896397, 3416.265502916835, 3455.6371580984137, 3501.0, 3525.524054252643, 3575.213453040327, 924.7377329944711, 932.128459890005, 933.4446004627235, 936.1481052242426, 936.4896131608153, 801.6592947997194, 827.98344033119, 829.6805729793952, 836.3518273338211, 840.5125027484045, 5276.915618330738, 5392.245085688007, 5428.728563571805, 5483.875805459871, 5595.636283641632, 822.942394032412, 855.7518319687346, 862.1163307609751, 878.6968495868915, 900.4237288135598, 3666.651668091527, 3821.063839359319, 3823.9426408603895, 3838.6353296436796, 3939.527256729211, 9554.092361225672, 9836.376997795283, 9991.550380232908, 10040.14658754014, 10060.849087263698, 9990.750231244278, 9993.10062094415, 9999.50002499872, 10001.199904007663, 10002.699649045577, 7287.708491660274, 7448.068991376078, 7541.47209695327, 7545.811354716176, 7547.320741133324, 5184.092783762751, 5249.816256431007, 5364.7585858635675, 5391.649542779707, 5652.3217213934595, 8800.207981281459, 9164.6792362267, 9191.816163676824, 9295.6281748732, 9394.81210375775, 9296.767580810534, 9301.534923253676, 9354.345195836226, 9495.572699228689, 9512.09635084666, 5709.514691251124, 5907.261592300963, 5907.85230369227, 6441.903371449338, 6612.669366531558, 6883.070785443901, 7275.34521893011, 7595.126560445619, 7672.5012874163, 7809.960950195213, 6849.1780986281965, 6937.340952609494, 6942.06282151903, 6973.302669733189, 7139.428845692229, 6744.0, 6762.763303284361, 6792.83017924536, 6846.897296540456, 6878.105846240157, 6501.804945851632, 6529.183852018497, 6567.540272180901, 6576.605403675795, 6638.90041649366, 4533.478649955297, 4636.11913736389, 4662.5104364042645, 4732.148213321498, 4886.584640305614, 4560.817567297271, 4654.837080702159, 4687.437507499122, 4770.761461926821, 4784.378030855966], "value": 4134.595837377173, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.45621267348577, 292.800895391134, 295.41507814527233, 295.8535524915166, 300.29880229663735, 4672.369230153929, 4805.0, 4822.156122678535, 4874.390701162359, 4880.804767809288, 4604.171249175147, 4759.571638552529, 4762.856914340559, 4767.425590181298, 4771.26045462953, 3769.7172712046568, 3780.395136778116, 3784.791836448994, 3785.6782173515217, 3791.696664266866, 3557.4485954677066, 3790.6019867913888, 3802.0, 3805.0867791729925, 3811.0, 3590.35373632746, 3742.7941463219513, 3751.1184871555297, 3755.2864955658474, 3762.698984081267, 3736.831842567091, 3737.177820879402, 3750.9624903750887, 3750.9684836670135, 3753.380692185786, 3299.884504042347, 3307.6361600223954, 3316.5241467546953, 3322.551455553518, 3339.1985923378456, 4531.957649740578, 4704.270838020112, 4704.952950470486, 4717.339572459859, 4719.764011799396, 4321.438213032286, 4321.567843215685, 4321.978390108061, 4323.848665296731, 4326.718763280408, 5008.84973450797, 5045.0, 5045.772940217699, 5047.293378926953, 5055.823046193365, 3308.354870800195, 3609.484016712987, 3620.6379362063844, 3623.7644553103964, 3633.4368172932973, 5199.272101905736, 5259.737013149327, 5260.553347829377, 5266.894662106736, 5268.236105764681, 3597.2985267873037, 3601.1537288737127, 3602.0, 3619.2580520993133, 3626.165981824195, 3650.8602601762464, 3660.1581636223286, 3670.6696397323835, 3671.9265614687556, 3679.6688298053305, 4077.55146933837, 4121.979390103031, 4186.3092589722355, 4189.476315460567, 4210.389493523483, 4979.701217926936, 4987.351644286219, 5017.767093643293, 5025.522575355335, 5042.268871013755, 1178.5933852820763, 1220.5727995201607, 1246.956356527517, 1264.525802823941, 1266.3351740336213, 838.1199740272812, 850.1923172985688, 853.7054716122927, 856.8928883889514, 857.8627419612957, 4397.142557201379, 4409.14021765759, 4412.602865742098, 4414.161309351213, 4420.9336859947125, 5150.613703972217, 5166.03690597578, 5172.612054095958, 5174.353205849269, 5177.197534382177, 4218.261804184255, 4413.44831896013, 4450.265706158448, 4495.752733599618, 4513.73615387692, 2759.434315965222, 2775.8195717278313, 2782.8191167574446, 2785.846778427206, 2789.595508651275, 4852.883836717504, 4877.853664390074, 4878.9022469943975, 4880.755962201875, 4890.0, 5185.611079169077, 5256.342957130359, 5330.9733451332495, 5347.652402593897, 5367.396812545912, 4807.855764327076, 4811.326414302001, 4828.444728856156, 4837.250226214942, 4845.345878306383, 4992.350994370709, 5201.0, 5211.426743058337, 5213.244079608511, 5216.556592689664, 5068.847934561969, 5086.0, 5089.0, 5096.51583099605, 5105.923411148761, 4828.672115168357, 4831.975840120777, 4844.588210002048, 4845.733484658378, 4859.0, 3591.3894637911094, 3597.226596281812, 3605.008622628798, 3608.837602307955, 3610.981945090258, 5023.723695196799, 5129.461406552258, 5171.379434467888, 5197.194434862602, 5216.426193118678, 5016.172331565251, 5019.974900125622, 5033.823816166563, 5040.57155141817, 5041.495850414929, 5006.374203224597, 5011.4487406386, 5015.793051057523, 5032.018756342624, 5062.822986116005, 4706.929396058993, 4817.542333478314, 4877.951280449719, 4992.975035124801, 5054.21659642756, 5024.824131155392, 5025.221090730943, 5112.520427592689, 5118.97440512795, 5129.128048231735, 4923.975380123076, 4945.629077819106, 4980.551750342486, 4996.575291100297, 5003.374578177728], "value": 3781.37258270684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.3261018906621, 658.8484648530838, 690.2855544511432, 705.277090981744, 735.2977906099674, 13581.456741730331, 14390.1365918045, 14440.783388249185, 14456.638584035405, 14505.129692218461, 13090.214587124756, 13253.006024548149, 13253.801192982113, 13269.734605307913, 13308.600741977756, 608.2062907905182, 730.9159446663622, 737.9446541509382, 758.2493331601702, 767.7044337929881, 760.0613242645329, 761.4251240313583, 761.7410080572604, 761.8552475029754, 761.9009528761281, 812.7074253268819, 814.1085511365046, 814.2061490047216, 814.543855440952, 814.861473549498, 635.9427651511363, 771.3828936850497, 794.0986979777936, 794.7258195922456, 799.672134424883, 577.1141298107427, 579.0763731847696, 579.5653260054959, 579.8492391978074, 580.0226618148433, 13252.602421927357, 13289.20264784116, 13302.135361201492, 13304.800427993589, 13317.600471985856, 12677.366131693378, 12853.742925141445, 12969.610911672666, 13499.055066145374, 13524.567650304829, 11629.534818607246, 11715.297082175097, 11765.470553825098, 11826.408679566073, 12151.210171338835, 4046.8583599574167, 4047.898802529931, 4069.267531844267, 4071.7149799514045, 4110.609492098246, 51520.48479515194, 52734.47265527334, 53056.204156937674, 53073.0, 63486.0, 10099.747506312255, 11047.447627618747, 11052.502637381338, 11173.0, 11417.600383986686, 19676.311329103413, 20454.284100056724, 20672.48318792042, 20761.169553217704, 20792.1683132676, 7057.964710176519, 7180.533265337841, 7229.89155162673, 7322.780316590511, 7502.287282708134, 3705.81470926458, 3713.0717320669833, 3732.5894151643297, 3743.6630703236838, 3815.923681526354, 2919.722626350493, 3033.4691428999836, 3040.2855328997666, 3042.2242328206166, 3044.4367791958557, 535.4377903201623, 546.1125670784975, 569.0951387294222, 582.624207386242, 586.9383714709979, 491.9631027672939, 530.933633295838, 591.9822405327847, 603.5925750118653, 612.8069658057698, 7571.924280757122, 7722.0, 8030.39772017101, 8808.20726134651, 8883.289336853037, 505.2698850161481, 526.6497778977014, 569.6582050769588, 576.2278546747378, 580.2369883603048, 3906.3554513505524, 4199.475065616798, 4200.936985945214, 4210.694684647769, 4338.522762496123, 57522.137167942514, 71029.6448517754, 91482.0, 105126.0, 105794.47102764591, 89701.0, 91103.54448227849, 92412.53793731122, 93389.0, 93625.5318723402, 45329.32006019913, 46125.0, 46436.5356346439, 46681.0, 47844.0, 7742.341900938483, 7931.5637639930355, 8151.388645851466, 8194.631241594261, 8270.710525131832, 38434.0, 47049.29426058543, 47190.76404617955, 48418.273725893436, 48915.266271005254, 63533.36466635275, 69656.6517167411, 69956.0, 70830.0, 75827.0, 10708.642637808409, 10830.837537437103, 10859.945700271765, 10991.120710342993, 11097.556097756322, 11751.0, 12047.879521205026, 12696.936515317733, 12700.682482938, 12794.232346059267, 10855.0, 11361.37512436824, 11501.367424791717, 11856.822147667965, 12016.879831201577, 10802.567897284021, 10999.505022274177, 11255.324680518868, 11784.646460606196, 12154.209976351509, 10874.0, 11019.83470247931, 11197.0, 11720.824187637021, 11723.120765942758, 8794.252488538546, 8915.73252802417, 9001.36990410665, 9308.348415610842, 9425.104615061558, 8890.288776897962, 8890.64437422496, 9442.38624489406, 9466.337356385262, 9683.0], "value": 6523.405302615989, "unit": "score"}], "name": "dromaeo_css", "value": 6323.783282521925, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 133.0, 117.0, 114.0, 118.0, 114.0, 114.0, 115.0, 113.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 124.0, 147.0, 185.0, 123.0, 153.0, 151.0, 126.0, 181.0, 124.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 162.0, 160.0, 162.0, 160.0, 162.0, 161.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 180.0, 77.0, 76.0, 80.0, 78.0, 165.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 137.0, 84.0, 84.0, 84.0, 134.0, 83.0, 82.0, 133.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 64.0, 62.0, 63.0, 64.0, 66.0, 62.0, 61.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 67.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 85.0, 91.0, 81.0, 84.0, 82.0, 82.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 130.0, 145.0, 139.0, 140.0, 141.0, 142.0, 174.0, 141.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 172.0, 175.0, 173.0, 173.0, 172.0, 175.0, 173.0, 172.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 68.0, 68.0, 69.0, 68.0, 70.0, 68.0, 69.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1575.7000000000003, "alertThreshold": 2.0}]} 21:33:35 INFO - Return code: 0 21:33:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:33:35 INFO - # TBPL SUCCESS # 21:33:35 INFO - Running post-action listener: _resource_record_post_action 21:33:35 INFO - [mozharness: 2016-08-26 04:33:35.335575Z] Finished run-tests step (success) 21:33:35 INFO - Running post-run listener: _resource_record_post_run 21:33:35 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 12288; Write bytes: 420708352; Read time: 320; Write time: 584584 21:33:35 INFO - TinderboxPrint: CPU usage
13.0% 21:33:35 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 320 21:33:35 INFO - TinderboxPrint: I/O write bytes / time
420,708,352 / 584,584 21:33:35 INFO - TinderboxPrint: CPU idle
8,352.3 (86.9%) 21:33:35 INFO - TinderboxPrint: CPU user
1,201.6 (12.5%) 21:33:35 INFO - TinderboxPrint: Swap in / out
0 / 0 21:33:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 113930240; Read time: 156; Write time: 192068 21:33:35 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289378304; Read time: 148; Write time: 386956 21:33:35 INFO - Running post-run listener: _upload_blobber_files 21:33:35 INFO - Blob upload gear active. 21:33:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:33:35 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 21:33:35 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:33:35 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:33:36 INFO - (blobuploader) - INFO - Open directory for files ... 21:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:37 INFO - (blobuploader) - INFO - Done attempting. 21:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:37 INFO - (blobuploader) - INFO - Done attempting. 21:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:41 INFO - (blobuploader) - INFO - Done attempting. 21:33:41 INFO - (blobuploader) - INFO - Iteration through files over. 21:33:41 INFO - Return code: 0 21:33:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:33:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:33:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93f68dd1c11110552f37a7dc28e5a3256179395406d1da3c496510d50b4229c8e49d8a507169034c87ee92c6b4a882cb9a8b4b7b4b9187282c33563195ab4fe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc264f1cf5d175fe3820becae42a6cc8e488f2a028920b4a0502dd861b1688847c63ae518cf8991b91b0214ea38139562f6218ae36fd7c95b7591b7dafeb4df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af5a398961de4b600a247af7e5f255761ff8d7f1f468dcdfad3cf00273ba570ed8dd093427fa72f3fe046deb0659184c18ac6f90f8ed3169c7caef1563625cc3"} 21:33:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:33:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:33:41 INFO - Contents: 21:33:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93f68dd1c11110552f37a7dc28e5a3256179395406d1da3c496510d50b4229c8e49d8a507169034c87ee92c6b4a882cb9a8b4b7b4b9187282c33563195ab4fe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc264f1cf5d175fe3820becae42a6cc8e488f2a028920b4a0502dd861b1688847c63ae518cf8991b91b0214ea38139562f6218ae36fd7c95b7591b7dafeb4df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af5a398961de4b600a247af7e5f255761ff8d7f1f468dcdfad3cf00273ba570ed8dd093427fa72f3fe046deb0659184c18ac6f90f8ed3169c7caef1563625cc3"} 21:33:41 INFO - Running post-run listener: copy_logs_to_upload_dir 21:33:41 INFO - Copying logs to upload dir... 21:33:41 INFO - mkdir: /builds/slave/test/build/upload/logs 21:33:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.912870 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-25 21:33:41.297831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 21:33:41.301445) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683 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-Non-PGO/sha512/93f68dd1c11110552f37a7dc28e5a3256179395406d1da3c496510d50b4229c8e49d8a507169034c87ee92c6b4a882cb9a8b4b7b4b9187282c33563195ab4fe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc264f1cf5d175fe3820becae42a6cc8e488f2a028920b4a0502dd861b1688847c63ae518cf8991b91b0214ea38139562f6218ae36fd7c95b7591b7dafeb4df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af5a398961de4b600a247af7e5f255761ff8d7f1f468dcdfad3cf00273ba570ed8dd093427fa72f3fe046deb0659184c18ac6f90f8ed3169c7caef1563625cc3"} build_url:https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/LtT0tV_uREa1kesv6e4yng/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-Non-PGO/sha512/93f68dd1c11110552f37a7dc28e5a3256179395406d1da3c496510d50b4229c8e49d8a507169034c87ee92c6b4a882cb9a8b4b7b4b9187282c33563195ab4fe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc264f1cf5d175fe3820becae42a6cc8e488f2a028920b4a0502dd861b1688847c63ae518cf8991b91b0214ea38139562f6218ae36fd7c95b7591b7dafeb4df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af5a398961de4b600a247af7e5f255761ff8d7f1f468dcdfad3cf00273ba570ed8dd093427fa72f3fe046deb0659184c18ac6f90f8ed3169c7caef1563625cc3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 21:33:41.326969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:33:41.327325) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472184481.679802-808047683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 21:33:41.410305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 21:33:41.410636) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 21:33:41.411011) ========= ========= Total master_lag: 0.19 =========