builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1472667748.43 results: success (0) buildid: 20160831083037 builduid: 7408cd8b0e2e49f1a89e42ebfb8a12be revision: 51afefd5f63d13b28b304c52301818cfad7d229b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.429273) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.429784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.430117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.465069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.465416) ========= 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=923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 11:22:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.0M=0s 2016-08-31 11:22:29 (31.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.612337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.612696) ========= 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=923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015768 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.662460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:28.662853) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 51afefd5f63d13b28b304c52301818cfad7d229b --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 51afefd5f63d13b28b304c52301818cfad7d229b --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=923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 11:22:29,938 truncating revision to first 12 chars 2016-08-31 11:22:29,938 Setting DEBUG logging. 2016-08-31 11:22:29,938 attempt 1/10 2016-08-31 11:22:29,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/51afefd5f63d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 11:22:30,192 unpacking tar archive at: fx-team-51afefd5f63d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:29.209169) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:29.209527) ========= script_repo_revision: 51afefd5f63d13b28b304c52301818cfad7d229b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:29.210055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:29.210434) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:22:29.222470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-31 11:22:29.223159) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:30 INFO - MultiFileLogger online at 20160831 11:22:30 in /builds/slave/test 11:22:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:22:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:30 INFO - {'append_to_log': False, 11:22:30 INFO - 'base_work_dir': '/builds/slave/test', 11:22:30 INFO - 'blob_upload_branch': 'Fx-Team', 11:22:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:30 INFO - 'branch': 'Fx-Team', 11:22:30 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:30 INFO - 'config_files': ('talos/linux_config.py',), 11:22:30 INFO - 'default_actions': ('clobber', 11:22:30 INFO - 'read-buildbot-config', 11:22:30 INFO - 'download-and-extract', 11:22:30 INFO - 'populate-webroot', 11:22:30 INFO - 'create-virtualenv', 11:22:30 INFO - 'install', 11:22:30 INFO - 'run-tests'), 11:22:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:30 INFO - 'download_minidump_stackwalk': True, 11:22:30 INFO - 'download_symbols': 'ondemand', 11:22:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:30 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:30 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:30 INFO - 'installer_path': 'installer.exe', 11:22:30 INFO - 'log_level': 'info', 11:22:30 INFO - 'log_name': 'talos', 11:22:30 INFO - 'log_to_console': True, 11:22:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:30 INFO - 'opt_config_files': (), 11:22:30 INFO - 'pip_index': False, 11:22:30 INFO - 'sps_profile': False, 11:22:30 INFO - 'sps_profile_interval': 0, 11:22:30 INFO - 'suite': 'dromaeojs', 11:22:30 INFO - 'system_bits': '32', 11:22:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:30 INFO - 'title': 'talos-linux64-ix-007', 11:22:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:30 INFO - 'use_talos_json': True, 11:22:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:30 INFO - 'work_dir': 'build'} 11:22:30 INFO - [mozharness: 2016-08-31 18:22:30.591189Z] Running clobber step. 11:22:30 INFO - Running pre-action listener: _resource_record_pre_action 11:22:30 INFO - Running main action method: clobber 11:22:30 INFO - rmtree: /builds/slave/test/build 11:22:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:31 INFO - Running post-action listener: _resource_record_post_action 11:22:31 INFO - [mozharness: 2016-08-31 18:22:31.553247Z] Finished clobber step (success) 11:22:31 INFO - [mozharness: 2016-08-31 18:22:31.553347Z] Running read-buildbot-config step. 11:22:31 INFO - Running pre-action listener: _resource_record_pre_action 11:22:31 INFO - Running main action method: read_buildbot_config 11:22:31 INFO - Using buildbot properties: 11:22:31 INFO - { 11:22:31 INFO - "project": "", 11:22:31 INFO - "product": "firefox", 11:22:31 INFO - "script_repo_revision": "production", 11:22:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:22:31 INFO - "repository": "", 11:22:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:22:31 INFO - "buildid": "20160831083037", 11:22:31 INFO - "pgo_build": "True", 11:22:31 INFO - "basedir": "/builds/slave/test", 11:22:31 INFO - "buildnumber": 1510, 11:22:31 INFO - "slavename": "talos-linux64-ix-007", 11:22:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:22:31 INFO - "platform": "ubuntu64_hw", 11:22:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:22:31 INFO - "branch": "fx-team", 11:22:31 INFO - "repo_path": "integration/fx-team", 11:22:31 INFO - "revision": "51afefd5f63d13b28b304c52301818cfad7d229b", 11:22:31 INFO - "stage_platform": "linux64-pgo", 11:22:31 INFO - "builduid": "7408cd8b0e2e49f1a89e42ebfb8a12be", 11:22:31 INFO - "slavebuilddir": "test" 11:22:31 INFO - } 11:22:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:22:31 INFO - Running post-action listener: _resource_record_post_action 11:22:31 INFO - [mozharness: 2016-08-31 18:22:31.555814Z] Finished read-buildbot-config step (success) 11:22:31 INFO - [mozharness: 2016-08-31 18:22:31.555905Z] Running download-and-extract step. 11:22:31 INFO - Running pre-action listener: _resource_record_pre_action 11:22:31 INFO - Running main action method: download_and_extract 11:22:31 INFO - mkdir: /builds/slave/test/build/tests 11:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:31 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:22:31 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:32 INFO - Downloaded 1361 bytes. 11:22:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:22:32 INFO - Using the following test package requirements: 11:22:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:22:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'jsshell-linux-x86_64.zip'], 11:22:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:22:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:22:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:32 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:22:32 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:32 INFO - Downloaded 21903642 bytes. 11:22:32 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 11:22:37 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 11:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:37 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:22:37 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:38 INFO - Downloaded 21903642 bytes. 11:22:38 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 11:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:42 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:42 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:43 INFO - Downloaded 14413998 bytes. 11:22:43 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 11:22:43 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')]} 11:22:43 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:22:43 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:22:45 INFO - Downloaded 59743264 bytes. 11:22:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:22:45 INFO - mkdir: /builds/slave/test/properties 11:22:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:45 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:45 INFO - Contents: 11:22:45 INFO - build_url:https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:22:45 INFO - Running post-action listener: _resource_record_post_action 11:22:45 INFO - Running post-action listener: set_extra_try_arguments 11:22:45 INFO - [mozharness: 2016-08-31 18:22:45.790318Z] Finished download-and-extract step (success) 11:22:45 INFO - [mozharness: 2016-08-31 18:22:45.790547Z] Running populate-webroot step. 11:22:45 INFO - Running pre-action listener: _resource_record_pre_action 11:22:45 INFO - Running main action method: populate_webroot 11:22:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:45 INFO - '--tppagecycles', 11:22:45 INFO - '7'], 11:22:45 INFO - 'tests': ['tsvgm']}}, 11:22:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['damp', 'tps']}, 11:22:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'tests': ['damp', 'tps']}, 11:22:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['dromaeo_dom']}, 11:22:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['basic_compositor_video']}, 11:22:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:22:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['a11yr', 11:22:45 INFO - 'ts_paint', 11:22:45 INFO - 'tpaint', 11:22:45 INFO - 'sessionrestore', 11:22:45 INFO - 'sessionrestore_no_auto_restore', 11:22:45 INFO - 'tabpaint']}, 11:22:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:45 INFO - 'ts_paint', 11:22:45 INFO - 'tpaint', 11:22:45 INFO - 'sessionrestore', 11:22:45 INFO - 'sessionrestore_no_auto_restore', 11:22:45 INFO - 'tabpaint']}, 11:22:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:45 INFO - 'ts_paint', 11:22:45 INFO - 'tpaint', 11:22:45 INFO - 'sessionrestore', 11:22:45 INFO - 'sessionrestore_no_auto_restore', 11:22:45 INFO - 'tabpaint']}, 11:22:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:45 INFO - 'ts_paint', 11:22:45 INFO - 'tpaint', 11:22:45 INFO - 'sessionrestore', 11:22:45 INFO - 'sessionrestore_no_auto_restore', 11:22:45 INFO - 'tabpaint']}, 11:22:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['a11yr', 11:22:45 INFO - 'ts_paint', 11:22:45 INFO - 'tpaint', 11:22:45 INFO - 'sessionrestore', 11:22:45 INFO - 'sessionrestore_no_auto_restore', 11:22:45 INFO - 'tabpaint']}, 11:22:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['a11yr', 11:22:45 INFO - 'ts_paint', 11:22:45 INFO - 'tpaint', 11:22:45 INFO - 'sessionrestore', 11:22:45 INFO - 'sessionrestore_no_auto_restore', 11:22:45 INFO - 'tabpaint']}, 11:22:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['tsvgx', 11:22:45 INFO - 'tsvgr_opacity', 11:22:45 INFO - 'tart', 11:22:45 INFO - 'tscrollx', 11:22:45 INFO - 'cart']}, 11:22:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:45 INFO - 'tsvgr_opacity', 11:22:45 INFO - 'tart', 11:22:45 INFO - 'tscrollx', 11:22:45 INFO - 'cart']}, 11:22:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'talos_options': ['--disable-e10s'], 11:22:45 INFO - 'tests': ['tp5o']}, 11:22:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'tests': ['tp5o']}, 11:22:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'talos_options': ['--disable-e10s', 11:22:45 INFO - '--xperf_path', 11:22:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:45 INFO - 'tests': ['tp5n']}, 11:22:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:45 INFO - 'talos_options': ['--xperf_path', 11:22:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:45 INFO - 'tests': ['tp5n']}}, 11:22:45 INFO - 'talos.zip': {'path': '', 11:22:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:45 INFO - Running post-action listener: _resource_record_post_action 11:22:45 INFO - [mozharness: 2016-08-31 18:22:45.813079Z] Finished populate-webroot step (success) 11:22:45 INFO - [mozharness: 2016-08-31 18:22:45.813169Z] Running create-virtualenv step. 11:22:45 INFO - Running pre-action listener: _resource_record_pre_action 11:22:45 INFO - Running main action method: create_virtualenv 11:22:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:22:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:45 INFO - Using real prefix '/usr' 11:22:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:46 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:48 INFO - Installing pip.................done. 11:22:48 INFO - Return code: 0 11:22:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:22:48 INFO - Using env: {'DISPLAY': ':0', 11:22:48 INFO - 'HOME': '/home/cltbld', 11:22:48 INFO - 'LANG': 'en_US.UTF-8', 11:22:48 INFO - 'LANGUAGE': 'en_US:en', 11:22:48 INFO - 'LOGNAME': 'cltbld', 11:22:48 INFO - 'MAIL': '/var/mail/cltbld', 11:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:48 INFO - 'MOZ_NO_REMOTE': '1', 11:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:48 INFO - 'NO_EM_RESTART': '1', 11:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:48 INFO - 'PWD': '/builds/slave/test', 11:22:48 INFO - 'SHELL': '/bin/bash', 11:22:48 INFO - 'SHLVL': '1', 11:22:48 INFO - 'TERM': 'linux', 11:22:48 INFO - 'TMOUT': '86400', 11:22:48 INFO - 'USER': 'cltbld', 11:22:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:48 INFO - '_': '/tools/buildbot/bin/python'} 11:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:22:48 INFO - Cleaning up... 11:22:48 INFO - Return code: 0 11:22:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:22:48 INFO - Using env: {'DISPLAY': ':0', 11:22:48 INFO - 'HOME': '/home/cltbld', 11:22:48 INFO - 'LANG': 'en_US.UTF-8', 11:22:48 INFO - 'LANGUAGE': 'en_US:en', 11:22:48 INFO - 'LOGNAME': 'cltbld', 11:22:48 INFO - 'MAIL': '/var/mail/cltbld', 11:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:48 INFO - 'MOZ_NO_REMOTE': '1', 11:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:48 INFO - 'NO_EM_RESTART': '1', 11:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:48 INFO - 'PWD': '/builds/slave/test', 11:22:48 INFO - 'SHELL': '/bin/bash', 11:22:48 INFO - 'SHLVL': '1', 11:22:48 INFO - 'TERM': 'linux', 11:22:48 INFO - 'TMOUT': '86400', 11:22:48 INFO - 'USER': 'cltbld', 11:22:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:48 INFO - '_': '/tools/buildbot/bin/python'} 11:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:48 INFO - Downloading/unpacking psutil>=3.1.1 11:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:50 INFO - Installing collected packages: psutil 11:22:50 INFO - Running setup.py install for psutil 11:22:50 INFO - building 'psutil._psutil_linux' extension 11:22:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:22:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:22:51 INFO - building 'psutil._psutil_posix' extension 11:22:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:22:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:22:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:51 INFO - Successfully installed psutil 11:22:51 INFO - Cleaning up... 11:22:51 INFO - Return code: 0 11:22:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22:51 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')]} 11:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:51 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')]} 11:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:51 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 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:22:51 INFO - Using env: {'DISPLAY': ':0', 11:22:51 INFO - 'HOME': '/home/cltbld', 11:22:51 INFO - 'LANG': 'en_US.UTF-8', 11:22:51 INFO - 'LANGUAGE': 'en_US:en', 11:22:51 INFO - 'LOGNAME': 'cltbld', 11:22:51 INFO - 'MAIL': '/var/mail/cltbld', 11:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:51 INFO - 'MOZ_NO_REMOTE': '1', 11:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:51 INFO - 'NO_EM_RESTART': '1', 11:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:51 INFO - 'PWD': '/builds/slave/test', 11:22:51 INFO - 'SHELL': '/bin/bash', 11:22:51 INFO - 'SHLVL': '1', 11:22:51 INFO - 'TERM': 'linux', 11:22:51 INFO - 'TMOUT': '86400', 11:22:51 INFO - 'USER': 'cltbld', 11:22:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:51 INFO - '_': '/tools/buildbot/bin/python'} 11:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:53 INFO - Installing collected packages: mozsystemmonitor 11:22:53 INFO - Running setup.py install for mozsystemmonitor 11:22:53 INFO - Successfully installed mozsystemmonitor 11:22:53 INFO - Cleaning up... 11:22:53 INFO - Return code: 0 11:22:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:22:53 INFO - Using env: {'DISPLAY': ':0', 11:22:53 INFO - 'HOME': '/home/cltbld', 11:22:53 INFO - 'LANG': 'en_US.UTF-8', 11:22:53 INFO - 'LANGUAGE': 'en_US:en', 11:22:53 INFO - 'LOGNAME': 'cltbld', 11:22:53 INFO - 'MAIL': '/var/mail/cltbld', 11:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:53 INFO - 'MOZ_NO_REMOTE': '1', 11:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:53 INFO - 'NO_EM_RESTART': '1', 11:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:53 INFO - 'PWD': '/builds/slave/test', 11:22:53 INFO - 'SHELL': '/bin/bash', 11:22:53 INFO - 'SHLVL': '1', 11:22:53 INFO - 'TERM': 'linux', 11:22:53 INFO - 'TMOUT': '86400', 11:22:53 INFO - 'USER': 'cltbld', 11:22:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:53 INFO - '_': '/tools/buildbot/bin/python'} 11:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:56 INFO - warning: no files found matching '*.txt' 11:22:56 INFO - no previously-included directories found matching 'build' 11:22:56 INFO - no previously-included directories found matching 'dist' 11:22:56 INFO - no previously-included directories found matching '.git*' 11:22:56 INFO - Installing collected packages: jsonschema, functools32 11:22:56 INFO - Running setup.py install for functools32 11:22:56 INFO - warning: no files found matching '*.txt' 11:22:56 INFO - no previously-included directories found matching 'build' 11:22:56 INFO - no previously-included directories found matching 'dist' 11:22:56 INFO - no previously-included directories found matching '.git*' 11:22:56 INFO - Successfully installed jsonschema functools32 11:22:56 INFO - Cleaning up... 11:22:56 INFO - Return code: 0 11:22:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:22:56 INFO - Using env: {'DISPLAY': ':0', 11:22:56 INFO - 'HOME': '/home/cltbld', 11:22:56 INFO - 'LANG': 'en_US.UTF-8', 11:22:56 INFO - 'LANGUAGE': 'en_US:en', 11:22:56 INFO - 'LOGNAME': 'cltbld', 11:22:56 INFO - 'MAIL': '/var/mail/cltbld', 11:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:56 INFO - 'MOZ_NO_REMOTE': '1', 11:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:56 INFO - 'NO_EM_RESTART': '1', 11:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:56 INFO - 'PWD': '/builds/slave/test', 11:22:56 INFO - 'SHELL': '/bin/bash', 11:22:56 INFO - 'SHLVL': '1', 11:22:56 INFO - 'TERM': 'linux', 11:22:56 INFO - 'TMOUT': '86400', 11:22:56 INFO - 'USER': 'cltbld', 11:22:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:56 INFO - '_': '/tools/buildbot/bin/python'} 11:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:56 INFO - Cleaning up... 11:22:56 INFO - Return code: 0 11:22:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:22:56 INFO - Using env: {'DISPLAY': ':0', 11:22:56 INFO - 'HOME': '/home/cltbld', 11:22:56 INFO - 'LANG': 'en_US.UTF-8', 11:22:56 INFO - 'LANGUAGE': 'en_US:en', 11:22:56 INFO - 'LOGNAME': 'cltbld', 11:22:56 INFO - 'MAIL': '/var/mail/cltbld', 11:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:56 INFO - 'MOZ_NO_REMOTE': '1', 11:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:56 INFO - 'NO_EM_RESTART': '1', 11:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:56 INFO - 'PWD': '/builds/slave/test', 11:22:56 INFO - 'SHELL': '/bin/bash', 11:22:56 INFO - 'SHLVL': '1', 11:22:56 INFO - 'TERM': 'linux', 11:22:56 INFO - 'TMOUT': '86400', 11:22:56 INFO - 'USER': 'cltbld', 11:22:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:56 INFO - '_': '/tools/buildbot/bin/python'} 11:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:59 INFO - Downloading docopt-0.6.1.tar.gz 11:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:59 INFO - Running setup.py install for blobuploader 11:22:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:59 INFO - Running setup.py install for requests 11:22:59 INFO - Running setup.py install for docopt 11:22:59 INFO - Successfully installed blobuploader requests docopt 11:22:59 INFO - Cleaning up... 11:22:59 INFO - Return code: 0 11:22:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:22:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:22:59 INFO - Using env: {'DISPLAY': ':0', 11:22:59 INFO - 'HOME': '/home/cltbld', 11:22:59 INFO - 'LANG': 'en_US.UTF-8', 11:22:59 INFO - 'LANGUAGE': 'en_US:en', 11:22:59 INFO - 'LOGNAME': 'cltbld', 11:22:59 INFO - 'MAIL': '/var/mail/cltbld', 11:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:59 INFO - 'MOZ_NO_REMOTE': '1', 11:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:59 INFO - 'NO_EM_RESTART': '1', 11:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:59 INFO - 'PWD': '/builds/slave/test', 11:22:59 INFO - 'SHELL': '/bin/bash', 11:22:59 INFO - 'SHLVL': '1', 11:22:59 INFO - 'TERM': 'linux', 11:22:59 INFO - 'TMOUT': '86400', 11:22:59 INFO - 'USER': 'cltbld', 11:22:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:59 INFO - '_': '/tools/buildbot/bin/python'} 11:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:00 INFO - Running setup.py (path:/tmp/pip-sRksNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:00 INFO - Running setup.py (path:/tmp/pip-Z_59VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:00 INFO - Running setup.py (path:/tmp/pip-nu43Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:00 INFO - Running setup.py (path:/tmp/pip-nnytrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:00 INFO - Running setup.py (path:/tmp/pip-ghqEEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:00 INFO - Running setup.py (path:/tmp/pip-Jd1Q2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:00 INFO - Running setup.py (path:/tmp/pip-u5jwkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:00 INFO - Running setup.py (path:/tmp/pip-pAHIju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:00 INFO - Running setup.py (path:/tmp/pip-xEjegV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:00 INFO - Running setup.py (path:/tmp/pip-WYt24p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:00 INFO - Running setup.py (path:/tmp/pip-i_rQTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:00 INFO - Running setup.py (path:/tmp/pip-F7MqRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:01 INFO - Running setup.py (path:/tmp/pip-A4f4UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:01 INFO - Running setup.py (path:/tmp/pip-B1LGIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:01 INFO - Running setup.py (path:/tmp/pip-w6X79Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:01 INFO - Running setup.py (path:/tmp/pip-yDk7qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:01 INFO - Running setup.py (path:/tmp/pip-OzzFAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:23:01 INFO - Running setup.py install for manifestparser 11:23:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:23:01 INFO - Running setup.py install for mozcrash 11:23:01 INFO - Running setup.py install for mozdebug 11:23:01 INFO - Running setup.py install for mozdevice 11:23:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:23:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:23:01 INFO - Running setup.py install for mozfile 11:23:01 INFO - Running setup.py install for mozhttpd 11:23:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Running setup.py install for mozinfo 11:23:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Running setup.py install for mozInstall 11:23:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Running setup.py install for mozleak 11:23:02 INFO - Running setup.py install for mozlog 11:23:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Running setup.py install for moznetwork 11:23:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Running setup.py install for mozprocess 11:23:02 INFO - Running setup.py install for mozprofile 11:23:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Running setup.py install for mozrunner 11:23:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:23:02 INFO - Running setup.py install for mozscreenshot 11:23:02 INFO - Running setup.py install for moztest 11:23:03 INFO - Running setup.py install for mozversion 11:23:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:23:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:23:03 INFO - Cleaning up... 11:23:03 INFO - Return code: 0 11:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:03 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')]} 11:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:03 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')]} 11:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:03 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 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:23:03 INFO - Using env: {'DISPLAY': ':0', 11:23:03 INFO - 'HOME': '/home/cltbld', 11:23:03 INFO - 'LANG': 'en_US.UTF-8', 11:23:03 INFO - 'LANGUAGE': 'en_US:en', 11:23:03 INFO - 'LOGNAME': 'cltbld', 11:23:03 INFO - 'MAIL': '/var/mail/cltbld', 11:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:03 INFO - 'MOZ_NO_REMOTE': '1', 11:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:03 INFO - 'NO_EM_RESTART': '1', 11:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:03 INFO - 'PWD': '/builds/slave/test', 11:23:03 INFO - 'SHELL': '/bin/bash', 11:23:03 INFO - 'SHLVL': '1', 11:23:03 INFO - 'TERM': 'linux', 11:23:03 INFO - 'TMOUT': '86400', 11:23:03 INFO - 'USER': 'cltbld', 11:23:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:03 INFO - '_': '/tools/buildbot/bin/python'} 11:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:03 INFO - Running setup.py (path:/tmp/pip-TNfzGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:03 INFO - Running setup.py (path:/tmp/pip-tQsO4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:03 INFO - Running setup.py (path:/tmp/pip-_r3tLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:03 INFO - Running setup.py (path:/tmp/pip-HW74iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:03 INFO - Running setup.py (path:/tmp/pip-YL53Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:03 INFO - Running setup.py (path:/tmp/pip-ThmLaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:03 INFO - Running setup.py (path:/tmp/pip-HAYdWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:03 INFO - Running setup.py (path:/tmp/pip-I7ykmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:03 INFO - Running setup.py (path:/tmp/pip-OXA3n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:04 INFO - Running setup.py (path:/tmp/pip-19JLoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:04 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)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:04 INFO - Running setup.py (path:/tmp/pip-RY735O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:04 INFO - Running setup.py (path:/tmp/pip-y4x4Tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:04 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)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:04 INFO - Running setup.py (path:/tmp/pip-evrn1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:04 INFO - Running setup.py (path:/tmp/pip-noaNSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:04 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)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:04 INFO - Running setup.py (path:/tmp/pip-tRo8zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:04 INFO - Running setup.py (path:/tmp/pip-ApYGr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:04 INFO - Running setup.py (path:/tmp/pip-6ZQRwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:23:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:06 INFO - Downloading blessings-1.6.tar.gz 11:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:06 INFO - Installing collected packages: blessings 11:23:06 INFO - Running setup.py install for blessings 11:23:06 INFO - Successfully installed blessings 11:23:06 INFO - Cleaning up... 11:23:06 INFO - Return code: 0 11:23:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:07 INFO - Reading from file tmpfile_stdout 11:23:07 INFO - Current package versions: 11:23:07 INFO - argparse == 1.2.1 11:23:07 INFO - blessings == 1.6 11:23:07 INFO - blobuploader == 1.2.4 11:23:07 INFO - docopt == 0.6.1 11:23:07 INFO - functools32 == 3.2.3-2 11:23:07 INFO - jsonschema == 2.5.1 11:23:07 INFO - manifestparser == 1.1 11:23:07 INFO - mozInstall == 1.12 11:23:07 INFO - mozcrash == 0.17 11:23:07 INFO - mozdebug == 0.1 11:23:07 INFO - mozdevice == 0.48 11:23:07 INFO - mozfile == 1.2 11:23:07 INFO - mozhttpd == 0.7 11:23:07 INFO - mozinfo == 0.9 11:23:07 INFO - mozleak == 0.1 11:23:07 INFO - mozlog == 3.3 11:23:07 INFO - moznetwork == 0.27 11:23:07 INFO - mozprocess == 0.23 11:23:07 INFO - mozprofile == 0.28 11:23:07 INFO - mozrunner == 6.12 11:23:07 INFO - mozscreenshot == 0.1 11:23:07 INFO - mozsystemmonitor == 0.3 11:23:07 INFO - moztest == 0.7 11:23:07 INFO - mozversion == 1.4 11:23:07 INFO - psutil == 3.1.1 11:23:07 INFO - requests == 1.2.3 11:23:07 INFO - wsgiref == 0.1.2 11:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:07 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 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:23:07 INFO - Using env: {'DISPLAY': ':0', 11:23:07 INFO - 'HOME': '/home/cltbld', 11:23:07 INFO - 'LANG': 'en_US.UTF-8', 11:23:07 INFO - 'LANGUAGE': 'en_US:en', 11:23:07 INFO - 'LOGNAME': 'cltbld', 11:23:07 INFO - 'MAIL': '/var/mail/cltbld', 11:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:07 INFO - 'MOZ_NO_REMOTE': '1', 11:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:07 INFO - 'NO_EM_RESTART': '1', 11:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:07 INFO - 'PWD': '/builds/slave/test', 11:23:07 INFO - 'SHELL': '/bin/bash', 11:23:07 INFO - 'SHLVL': '1', 11:23:07 INFO - 'TERM': 'linux', 11:23:07 INFO - 'TMOUT': '86400', 11:23:07 INFO - 'USER': 'cltbld', 11:23:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:07 INFO - '_': '/tools/buildbot/bin/python'} 11:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:23:07 INFO - Cleaning up... 11:23:07 INFO - Return code: 0 11:23:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:07 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 0x7f2e64e88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f738d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, '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': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:23:07 INFO - Using env: {'DISPLAY': ':0', 11:23:07 INFO - 'HOME': '/home/cltbld', 11:23:07 INFO - 'LANG': 'en_US.UTF-8', 11:23:07 INFO - 'LANGUAGE': 'en_US:en', 11:23:07 INFO - 'LOGNAME': 'cltbld', 11:23:07 INFO - 'MAIL': '/var/mail/cltbld', 11:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:07 INFO - 'MOZ_NO_REMOTE': '1', 11:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:07 INFO - 'NO_EM_RESTART': '1', 11:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:07 INFO - 'PWD': '/builds/slave/test', 11:23:07 INFO - 'SHELL': '/bin/bash', 11:23:07 INFO - 'SHLVL': '1', 11:23:07 INFO - 'TERM': 'linux', 11:23:07 INFO - 'TMOUT': '86400', 11:23:07 INFO - 'USER': 'cltbld', 11:23:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:07 INFO - '_': '/tools/buildbot/bin/python'} 11:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:23:07 INFO - Cleaning up... 11:23:07 INFO - Return code: 0 11:23:07 INFO - Running post-action listener: _resource_record_post_action 11:23:07 INFO - Running post-action listener: _start_resource_monitoring 11:23:07 INFO - Starting resource monitoring. 11:23:07 INFO - [mozharness: 2016-08-31 18:23:07.502844Z] Finished create-virtualenv step (success) 11:23:07 INFO - [mozharness: 2016-08-31 18:23:07.503354Z] Running install step. 11:23:07 INFO - Running pre-action listener: _resource_record_pre_action 11:23:07 INFO - Running main action method: install 11:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:07 INFO - Reading from file tmpfile_stdout 11:23:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:07 INFO - Reading from file tmpfile_stdout 11:23:07 INFO - Output received: 11:23:07 INFO - Usage: mozinstall [options] installer 11:23:07 INFO - Options: 11:23:07 INFO - -h, --help show this help message and exit 11:23:07 INFO - -d DEST, --destination=DEST 11:23:07 INFO - Directory to install application into. [default: 11:23:07 INFO - "/builds/slave/test"] 11:23:07 INFO - --app=APP Application being installed. [default: firefox] 11:23:07 INFO - mkdir: /builds/slave/test/build/application 11:23:07 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'] 11:23:07 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 11:23:24 INFO - Reading from file tmpfile_stdout 11:23:24 INFO - Output received: 11:23:24 INFO - /builds/slave/test/build/application/firefox/firefox 11:23:24 INFO - Running post-action listener: _resource_record_post_action 11:23:24 INFO - [mozharness: 2016-08-31 18:23:24.815318Z] Finished install step (success) 11:23:24 INFO - [mozharness: 2016-08-31 18:23:24.815661Z] Running run-tests step. 11:23:24 INFO - Running pre-action listener: _resource_record_pre_action 11:23:24 INFO - Running main action method: run_tests 11:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:24 INFO - Python 2.7.3 11:23:24 INFO - Return code: 0 11:23:24 INFO - grabbing minidump binary from tooltool 11:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2002760>, '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 0x2003660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2003af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:23:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:23:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:23:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:24 INFO - Return code: 0 11:23:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:23:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:23:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 11:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 11:23:24 INFO - Using env: {'DISPLAY': ':0', 11:23:24 INFO - 'HOME': '/home/cltbld', 11:23:24 INFO - 'LANG': 'en_US.UTF-8', 11:23:24 INFO - 'LANGUAGE': 'en_US:en', 11:23:24 INFO - 'LOGNAME': 'cltbld', 11:23:24 INFO - 'MAIL': '/var/mail/cltbld', 11:23:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:24 INFO - 'MOZ_NO_REMOTE': '1', 11:23:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:24 INFO - 'NO_EM_RESTART': '1', 11:23:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:24 INFO - 'PWD': '/builds/slave/test', 11:23:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:24 INFO - 'SHELL': '/bin/bash', 11:23:24 INFO - 'SHLVL': '1', 11:23:24 INFO - 'TERM': 'linux', 11:23:24 INFO - 'TMOUT': '86400', 11:23:24 INFO - 'USER': 'cltbld', 11:23:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641', 11:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:24 INFO - '_': '/tools/buildbot/bin/python'} 11:23:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 11:23:25 INFO - mozversion application_buildid: 20160831083037 11:23:25 INFO - mozversion application_changeset: 51afefd5f63d13b28b304c52301818cfad7d229b 11:23:25 INFO - mozversion application_display_name: Nightly 11:23:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:25 INFO - mozversion application_name: Firefox 11:23:25 INFO - mozversion application_remotingname: firefox 11:23:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:23:25 INFO - mozversion application_vendor: Mozilla 11:23:25 INFO - mozversion application_version: 51.0a1 11:23:25 INFO - mozversion platform_buildid: 20160831083037 11:23:25 INFO - mozversion platform_changeset: 51afefd5f63d13b28b304c52301818cfad7d229b 11:23:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:23:25 INFO - mozversion platform_version: 51.0a1 11:23:25 INFO - using testdate: 1472667805 11:23:25 INFO - actual date: 1472667805 11:23:25 INFO - starting webserver on 'localhost:38646' 11:23:25 INFO - SUITE-START | Running 2 tests 11:23:25 INFO - TEST-START | dromaeo_css 11:23:25 INFO - operating with platform_type : linux_ 11:23:25 INFO - Initialising browser for dromaeo_css test... 11:23:25 INFO - TEST-INFO | started process 14099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRZFe9o/profile http://localhost:38646/getInfo.html) 11:23:28 INFO - PROCESS | 14099 | __metrics Screen width/height:1600/1200 11:23:28 INFO - PROCESS | 14099 | colorDepth:24 11:23:28 INFO - PROCESS | 14099 | Browser inner width/height: 1024/697 11:23:28 INFO - PROCESS | 14099 | __metrics 11:23:29 INFO - PROCESS | 14099 | 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" 11:23:29 INFO - PROCESS | 14099 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:23:29 INFO - PROCESS | 14099 | console.error: PushService: 11:23:29 INFO - PROCESS | 14099 | stateChangeProcessEnqueue: Error transitioning state 11:23:29 INFO - PROCESS | 14099 | UnknownError 11:23:30 INFO - TEST-INFO | 14099: exit 0 11:23:30 INFO - Browser initialized. 11:23:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:30 INFO - TEST-INFO | started process 14177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRZFe9o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:42 INFO - PROCESS | 14177 | RSS: Main: 180867072 11:23:42 INFO - PROCESS | 14177 | 11:24:34 INFO - PROCESS | 14177 | 1472667874483 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:26:43 INFO - PROCESS | 14177 | Cycle 1(1): loaded http://localhost:38646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38646/tests/dromaeo/cssquery-ext.html) 11:26:44 INFO - PROCESS | 14177 | RSS: Main: 268619776 11:26:44 INFO - PROCESS | 14177 | 11:29:47 INFO - PROCESS | 14177 | Cycle 1(1): loaded http://localhost:38646/tests/dromaeo/cssquery-ext.html (next: http://localhost:38646/tests/dromaeo/cssquery-jquery.html) 11:29:47 INFO - PROCESS | 14177 | RSS: Main: 272338944 11:29:47 INFO - PROCESS | 14177 | 11:32:49 INFO - PROCESS | 14177 | Cycle 1(1): loaded http://localhost:38646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38646/tests/dromaeo/cssquery-mootools.html) 11:32:50 INFO - PROCESS | 14177 | RSS: Main: 213086208 11:32:50 INFO - PROCESS | 14177 | 11:35:52 INFO - PROCESS | 14177 | Cycle 1(1): loaded http://localhost:38646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38646/tests/dromaeo/cssquery-prototype.html) 11:35:52 INFO - PROCESS | 14177 | RSS: Main: 234389504 11:35:52 INFO - PROCESS | 14177 | 11:38:55 INFO - PROCESS | 14177 | Cycle 1(1): loaded http://localhost:38646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38646/tests/dromaeo/cssquery-yui.html) 11:38:56 INFO - PROCESS | 14177 | RSS: Main: 212692992 11:38:56 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | Cycle 1(1): loaded http://localhost:38646/tests/dromaeo/cssquery-yui.html (next: http://localhost:38646/tests/dromaeo/cssquery-dojo.html) 11:41:59 INFO - PROCESS | 14177 | RSS: Main: 304926720 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | __start_tp_report 11:41:59 INFO - PROCESS | 14177 | _x_x_mozilla_page_load 11:41:59 INFO - PROCESS | 14177 | _x_x_mozilla_page_load_details 11:41:59 INFO - PROCESS | 14177 | |i|pagename|runs| 11:41:59 INFO - PROCESS | 14177 | |0;dojo.html;3081.0602766156326;3091.4744493436115;3104.068779366191;3137.8744850205994;3165.129589362925;5221.373435187783;5333.573314134869;5375.623706340558;5422.945770542294;5425.5117039466395;5423.620346575742;5447.073997420438;5476;5513.365962914276;5551.250581171541;4857.465678775332;4886.706797592155;4944;4954.2568614707725;5023.723695196781;4944.110060189165;4966.776495057731;4968.950310496903;4990.625703072266;4994.051130285252;4819.759012049419;4825.745306220408;4861.538153875376;4862.3922009748785;4956.2070068789;4761.880952976168;4884.19410797218;4945.851624451272;4956.306117143603;4968.527989840959;4701.341812146302;4773.021530586221;4777.546133117348;4793.089313030548;4800.255960326155;5311.176767601028;5315.893682126374;5328.46715328468;5329.094054010828;5334.03987282289;5524.309461317335;5647.548196144298;5699.772009119631;5711.543076553866;5717.313922329306;5691.7723291068305;5750.6262092963825;5756.942430575725;5763.971180144073;5768.625039372428;5356.651817631841;5357.223202635596;5358.303420555303;5359.196120581866;5369.301990741257;5811.506021988093;5884.9705751470965;5898.852528686732;5917.171595976567;5981.282246130492;5645.153227015899;5647.604667673306;5660.716964151776;5660.8867822643315;5661.716914154358;5660.037793575102;5732.0255556555485;5760.337561180434;5773.162891380726;5773.191753154561;5616.101423772258;5676.971615141981;5686.687232202268;5770.480656740913;5781.046127388934;5686.687232202268;5733.655980641175;5734.913976290359;5737.454941780524;5740.827775166752;4404.911901761947;4438;4441.489228738672;4444.1111777643955;4488.977555112204;3864.42033694948;3895.552011518655;3944.625260600296;3960.9009774755286;3992.061865461614;5440.591955603267;5446.2375267462585;5448.972755136199;5449.373322067933;5502.9174562381595;5740.13897915316;5753.165790960287;5753.165790960371;5753.252077229933;5753.597248192586;5423.701696406735;5426.864328391822;5463.344398672105;5515.090010148361;5531.502164805187;5037.571806396498;5038.974805126024;5043.773030213649;5051.4695956924;5088.592912566985;5972.40275972408;6005.129256257818;6011.428914253139;6013.188219590387;6017.6938310428495;5708.743106560298;5727.8854422912145;5780.0173970424285;5808.099744539603;5945.19739835134;5954.166416701752;5972.283326000907;5973.402659733992;5973.432523910222;6028.125921741235;5669.801556945487;5705.486506214461;5715.228444159985;5718.428157184415;5725.6850873202375;5712.571557133315;5777.971110144423;5778.133280007864;5807.651540907559;5860.531157507475;5561.082421400585;5610.5231055360755;5612.7193640317;5705.429457054262;5717;5581.637193582566;5636.88726225465;5638.23883775685;5642.605017648725;5643.802466913638;5554.777808887599;5572.331320241435;5575.247341608993;5575.972120139373;5581.553475721851;5545.334559852843;5613.382527921844;5651.124075768263;5664.886702266014;5761.164631128547;5523.337199536081;5548.55611551083;5551.694656793915;5554.222408862682;5563.332400112013 11:41:59 INFO - PROCESS | 14177 | |1;ext.html;586.7066466766616;603.8550747820523;628.2774808969688;638.4860187549021;643.0739734781914;32235.51646725298;33024.83487582562;43512.782436087815;43595.07644312011;43811.78094109533;40983;44661;44684.53154684538;44731.77634111833;44784;8768.079351668062;8895.021547629756;8895.95552022239;8908.153725396109;8917.063708310632;8954.2836573074;9036.909630903672;9041.231495322905;9047.366684332099;9052.27581793455;9064.592093355783;9100;9105.36262461628;9117.361784675075;9120.17918387345;8971.237444817132;9011.774705632379;9012.819743605123;9039.276857851357;9040;8947.955260223722;9008.954955225248;9010.729678109667;9020.909790902138;9022.50376229307;42153.78923105365;42461.787691061654;42799;42904.356434653506;42918.57081429177;3490.9127271818406;3581.5344005279408;3626.3291291111227;3663.19409729859;3685.668289853926;31939.201519961953;32055.679443205503;32067.198320042186;32331.6766832331;32460.513092303634;4287.228298906196;4360;4363.3018717005125;4386.495553011413;4458.598726114666;349628;351628;351881.24059379793;352050;352397;56680.71659641675;57093.714531427075;57153.428465715646;57210;57279.71360143173;36360.818195908854;37204.62795372012;59959.70020149959;60023;60091.69954150289;15409.152496612794;15810.92094539543;15871.761923571155;15890.920545397199;15896.12571308566;11620.767584648429;11630.069594432425;11651.00966417864;11660.06719462441;11667.066634669207;18985.43043708691;19064.904675476533;19095.809041909404;19159.233630654897;19175.137118829687;6906.412954898789;7112.822179445452;7113.597762014125;7299.744508942162;7399.445041621792;946.2902822882838;1041.7135287795766;1085.9944506876982;1095.1457862866976;1112.872019717743;31526.684733152833;31668.841655791573;31923.84038079795;32250.838745806122;32296.677033229837;925.7222833150028;1084.219362059316;1100.8128618134936;1120.4005856866538;1148.8506494155706;15513.681337086475;16603.750943735853;16634.6673066538;16635.419635134644;16920.91539542319;550502;557449;560409;567412;884462;58318.41681583215;58707.412925871045;58715.70642146762;58756;58917.93787217427;1228.0482625964771;1289.374653293152;1304.523848795202;1305.092960392518;1340.4102195034154;30027.549586756653;32374.676253237165;32427.18932026624;32463.513047303837;32849.34301314008;49020.529384118534;49710.75144624254;49750.502494974586;49824.50175498199;49889.75055124701;445540;447071;448600;448853;450102;27353.589696154973;27960;28107.297317567223;29082.854585726935;29350.853245733633;46956.7652161737;47105.2934205994;48152.27771583499;48671;48939.75530122327;38335.42496862605;40428.79785601053;40665.39001914914;41323.1735365297;42383;39260;39424.605753943244;39601.80199098986;40869;41174;33389.33221335511;35947.64052359547;37918.43122353222;39656.801715991234;40618.390724139754;33627.32745345031;35497.5979406639;36082.8195859019;36251.81874090718;36320.45519317265;27166.456670866868;27193.1842044739;27264.454710905273;27271.318217044733;27308.31729206786 11:41:59 INFO - PROCESS | 14177 | |2;jquery.html;387.7867173054819;398.2254514968388;401.3578274760384;404.7470331043098;423.96608271338295;13146.816786489215;18391.72412413815;20267.797322026792;20361;20476.488087797814;19130.521736956583;19237.134328955195;19648.607027859434;19923.800761992377;19957.301494447696;5417.079096553585;5565.749541270652;5570.415106413829;5570.972145139269;5590.86022849428;5719.628224165437;5812.070068788995;5812.534997200235;5812.854678633047;5815.854603634922;4325.091730736549;6251.218597675291;6461.321561236073;6507.4143327100555;6613.239477460105;6327.133495618804;6405.583637063576;6515.609063456208;6577.7368905243975;6583.473322134242;5770.596058275923;5789;5800.709964501801;5800.738966746507;5803.071508558611;22348.776512234996;23465.648015279785;23631.645525317133;23648.527029459485;23868;2424.866632335221;2453.865037422941;2565.307367010915;2601.8829152688177;2897.4060317635044;10233.334833235816;10630.46847657614;14327.856721432756;14543;15131.697366052727;1910.3791267838008;1957.1290775604862;1962.1856929374292;1972.7336809530816;1999.6700544410155;69228.6538567309;69250;75561.62219188924;83705.58147209286;85328.14671853326;10949.781004379867;11066.502007409686;11100.222984391177;11274.830877536844;11470.139739519569;16109.113998729948;16136.75794863078;16158.111303878399;16167.110808905389;16205.432809851598;7597.962010189914;7770.456068075294;7884.369250459949;8040;8056.959715201387;7187.9640601796655;7266.309700578437;7268.418526517866;7487.925120748831;7525.285097915689;4803.639727020487;4813.7352445615825;4824.155772739757;4879.243717223836;5017.272495488134;1939.7478327817294;1994.9102290396968;2039.567611666316;2059.929770580587;2116.47088227943;858.9957050214709;879.569011184515;922.6401703335705;960.4765402855321;1026.7946410717886;18722.157502912403;19948.50128746793;19990.60018799645;20151.49621259451;20161.193552257744;900.7658008917729;912.8721978922956;936.3960245641523;961.2310151878469;974.3666616699061;10444.529996150039;11084.889151108548;11132.38771867555;11132.721681957853;11146.609868654721;461953;462494;465636;466370;472423;77594;94512.52743736237;95796.52101739447;97202;98342.50828745954;930.9860352094724;959.8896126945351;985.7634167799677;993.5826952679892;994.3884511025811;17558.20988055566;17723;18204.72692909581;18341.174647140644;18605.81394186095;42460;43304.78347608368;44045.55954440415;44080.77959610181;44824.55175448334;54636.453635463135;56283;58059.709701451226;58665.70667146808;59021.671207539366;5832.62087964281;6340.556161068681;7461.955326254438;7728.845423091394;7989.161138080418;7879.644003414387;11097.611583594535;11506.712332191428;13474.797878032034;13592;11711.941440292743;11918.940405297919;11934.641960741192;11949.462274197507;11989.460474278852;11124.276922000045;11449.828252576384;11797.76404471923;12047.975922046724;12222.572209972608;12089.274643521418;12198.939005304917;12494;12674.176178548365;12975.935120324339;8182.509049457051;8208.58957052157;8332.625031873702;8373.539455330016;8498.830023399621;10608.840867387149;12018.399080046138;12028.819567706667;12126.75746485083;12412.069094817743 11:41:59 INFO - PROCESS | 14177 | |3;mootools.html;1374.6700791809965;1456.1263242054765;1505.8042454480915;1649.983500164998;1767.2400867626923;8640.567971601418;9395.530223488833;9397.953010234947;9399.483028433433;9407.905920940797;7804.765857024284;8597.269232115263;8754.518501482416;8816.603252853622;9176.449413035205;2373.32360277321;2401.7838394544488;2406.242033759369;2407.963880541793;2408.9638655420094;2348.1781376518165;2386.59427897257;2417.4560723837085;2421.891014904325;2423.72127205371;2397.460571371445;2397.4845408237225;2405.3385319037316;2419.5765740995344;2426.1751004658413;2328.1269523928527;2338.6141286687675;2346.0263990443946;2350.905963761456;2375.263668262844;2315.5253173099472;2333.556624241389;2335.1710142899196;2341.484873327865;2346.155384061736;9129.589168487433;9225.308101892386;9275.443473391551;9292.907070929272;9302.953485232598;5281.287026251483;5422.186671999192;5429.348478182604;5449.291592093042;5451.945480545223;3528.523649307336;3535.3636345457808;3582.6417358264225;3618.348697234523;3619.438986957026;1155.4280631087581;1159.2928313728619;1162.6047143971007;1187.584345479084;2166.3176099528755;12640.49438022478;12730.80903786444;12811;12843.999999999907;12855;4187.183499217624;4512.751798651106;4588.724676519353;4671.6262698984;4698.201305778026;10006.848527566608;10007.699769006942;10010;10013.599456021822;10034.197264218845;5246.947530524722;5269.235960785664;5279.419263881046;5316.229146773696;5320.920186197211;4374.081442897027;4805.831795887197;4883.853484395474;4914.655974081851;4927.507249275044;3948.9210215795524;3955.2287303976022;4000.5399379071196;4033.072393349546;4052.4731784867777;1191.3090407563593;1220.0113814482338;1231.9199252048588;1233.747081848219;1243.4963839644959;811.2131232704268;856.1805221411487;899.7615631857562;906;940.9200217981548;5777.45114214149;5817.505512031525;5870.618409803349;5996.67018313997;6016.69916504173;856.1181982557976;901.724973882972;927.7402327348353;935.9485228312508;993.0417147452742;3888.416737489399;4015.437838702584;4023.1752490739327;4125.133721918371;4205.095904380573;11047.72380690489;11504.252223605607;11508.88491115078;11518.36648984314;11521.654350369503;11367.886321136848;11374.20380573352;11389.544418223179;11398.316101033799;11423.200375973769;8500.362472814564;8611.698590549426;8621.91378086211;8630.78423039429;8638.308935285162;5889.087191485327;5896.970515147568;5949.345571986992;6119.082137679384;6242.975781988092;9917;10086.495675216356;10295.279330447096;10299.794004120025;10316.793664126826;10520.736981575521;10543.525541350811;10557.260991730505;10605.787884242427;10684.83972740425;7829.5302281860995;7862.135165131716;7924.762257132295;7978.800529986796;8041.597920103854;9043.728688139367;9115.726528204164;9120.908790912272;9125.087491250822;9131.817363652823;7949.443538952449;8069.83860322802;8094.676212951416;8166.032018182237;8355.540445275568;7946.284834364935;7950.761477155695;8053.35573154158;8057.637406316612;8156.469829461066;7240.05879235696;7419.591922444318;7456.7390141344795;7519.248075192656;7527.2849079337375;4965.900681986268;5124.461931497288;5133.7689803958165;5233.921491177559;5357.785688572413;5039.294498770102;5095.414027386898;5108.182690769459;5123.872747995435;5262.526492582083 11:41:59 INFO - PROCESS | 14177 | |4;prototype.html;327.5772406720679;340.6236109099445;345.79252448530883;346.7139609821896;347.67145047929716;5356.303680521536;5356.705381204032;5359.142537194045;5371.328583927009;5390.51485366317;5056.898862022757;5106.64253502255;5218.556422704075;5225.738713064341;5335.493128152819;4158.293090174662;4160.542340342575;4176.18564379946;4179.686523510733;4183;4167.020665184028;4183.435236243114;4185.434966279559;4194.119234960646;4226.429432026668;3931.4889064421727;4061.8578349757763;4147.5645057269;4155.916881662365;4157.521884983235;4147.8963025924295;4148.668106551499;4152.626263636287;4163.437935878663;4163.770992595406;3710.4990826238654;3725.8695945642044;3727.7949712765785;3743.9142648631864;3764.0213544478634;5017.437619290308;5122.462141475166;5155.561777248939;5257.579393648537;5258.842234732926;4759.667293157921;4767.165745994437;4769.546893045155;4770.904581908342;4774.543764151932;5467;5470.398256191816;5508.338999320067;5510.752016159242;5518.558515318765;3905.4839046874745;4037.798110094513;4048.5748996355255;4069.633732964018;4076.5324483186027;5669.744861481243;5673.177389278573;5686;5693.715314234271;5707.686077265748;4170.332746760564;4172.7913604319665;4189.790510474464;4203.978980105141;4233.872983810491;4109.568495308009;4272.29507131326;4276.166147601188;4277.732801615149;4278.4010238566625;4741.312509686076;4741.83403580873;4753.621449779525;4807.567318941312;4826.734529600835;5494.560435165257;5513.58648101394;5517.282753242052;5555.666660000413;5582.972085139549;1391.8190635217356;1446.5443385333585;1467.3543640798014;1467.3763650448516;1490.4559835659907;950.8431108867098;951.5765484359532;954.5131982688879;962.167724917941;979.8530220466987;4473.731576105444;4697.929531057037;4719.834805781781;4726.220173671374;4755.83354582588;4923.9167383175645;4935.531124543163;4945.703257804544;4956.702597844141;4990.426100998432;4704.435467743892;4715.127701375257;4715.434147902273;4728.763561821964;4738.597219236403;2486.490269494749;2641.564141916601;2643.035292118363;2652.6418933444124;2660.388110734542;5136.383633963948;5158.871028224325;5159.968006398735;5178.352705911761;5185.377754669464;5061.569766569883;5064.569511591556;5094.745262736848;5101.897962040738;5119.312361010425;4887.095887260868;5034.546890779848;5100.209467532539;5120.692758434506;5130.692158470354;4934.358533390637;4937.728424936519;4948.713334532976;5027.50038715355;5041.395032596112;4974.602031837517;5028.874278142929;5030.220315851049;5038.521340472649;5055.898882022266;4986.301917731593;4989.675671081368;5078.7206703631655;5199.2184181462735;5210.869728256824;3769.5696915806484;3776.2258736959407;3790.469334293146;3790.6019867913474;3813.8093095344566;4977.900441991067;5397.757100930546;5594.216809646734;5632.295963004624;5639.8590035249445;5307.840764777063;5486.341639003345;5554.416786237387;5560.498665360249;5562.249096371938;5289.233061206027;5468.332158691637;5474.206240095244;5495.972520137374;5519;5461.836144915659;5498.697571633438;5523.4200408956485;5533.446655334435;5545.3622833373065;5576.721163941867;5608.4111168326735;5620.718964051863;5626.578006649435;5629.577781666309;5221.712805795718;5451.672899626035;5486.204500347507;5486.31421072366;5508.3114610673665 11:41:59 INFO - PROCESS | 14177 | |5;yui.html;757.9583122928238;763.564768082193;782.2920257167262;799.0451410564374;822.0966928167942;15360.84639153608;16156;16206.351745930178;16221.270042848086;16292.674146517062;14977.326020329085;15084.622884427894;15098.245087745596;15126.092434453913;15137.31882065307;655.302103260029;764.3044829205425;772.289493665826;783.0681489028067;783.4241832253289;774.9496282741632;782.8160382310152;782.9608519574027;783.1541934710499;783.7178615698344;828.1676914700718;829.8796674482196;829.9751007469786;830.5182993863544;830.5805568188086;674.7638326585704;810.9756707298791;816.4692949582759;818.3085292927497;824.4640983360804;620.2185246589285;621.5649045668006;621.6767281013892;621.7885918787634;621.8227805075577;14164.645883852883;14272.643183920381;14279.21464319462;14287.214203218819;14309.212993285366;14260.215688137148;14744.336504857307;14895.329710163069;14918;14938.178400187986;13361.799573006412;13598.252096134709;13626.318684065856;13631.386587603582;13712.794308085387;4347.260965635849;4358.150160718661;4419.359192917009;4442.511323754385;4597.793099310539;81217;82597.58701206456;82874.49696303184;84940.57529712374;85621.14378856194;11637;11781.175317727677;11838.644840654793;11924.76150477003;12102.697432564257;19959.501012474804;19972.600547988957;20044.298449554197;20056.197752089753;20080;8250.669973201126;8338.124496927736;8418.747437576883;8435.11431299717;8765.517896515752;4459.241928872099;4486.282194848808;4506.797194126272;4608.1474927137915;4640.23436133041;3419.692227699469;3514.5431093957623;3521.2429327694667;3524.048506903122;3525.6121826599056;597.8027251007157;604.2175382879094;621.4034526854181;622.7135517661835;623.9500839932795;606.7815586388897;633.398271641942;678.1218322272669;711.921688614252;713.1264201353405;8981.820363592822;9363.859542106873;9444.338896277332;9805.362651427635;9922.553485093189;660.3495556876472;693.1197379328225;696.6377483708443;724.8695234857777;727.2146082231178;4294.1220293525785;4411.9558804411545;4519.502854685982;4540.250858608359;4694.131585656596;66936.66531667407;66967;67192.6640366795;98766.5061674687;121954;67087.32912670908;86453.56773216094;104650.47674761577;106488.46755766172;111161;59692;75531.24468755242;89357;92384.53807730919;92630;8273.875891861506;8294.294984926108;8468.788280293042;8554.828903422022;8586.699465518677;52119.47880521146;52743.73628131835;53019.46980530145;53919.46080539301;54041.10856120017;75792.62103689446;75817.62091189729;76174;78437.60781196058;79209;11656;11795.764084718428;11881.82177267359;12081.214721043105;12286.262824230575;12970.805437918627;12977.35113244353;13186.142900711424;13696.452141914211;13761.211042564402;13181.80227296572;13594.252316122709;13681.384337705027;13792.517261895786;14008.089474184146;14058.507952221624;14342.928285358506;14516.927415362856;14520.273986300854;15048.247587620357;13276.60170194857;13467.595972120853;13601.183928964294;14238.216898070292;14518.63703407381;10449.320794148356;10531.78936421252;11406.362173536329;11427.828582571434;11662.76674466489;11001.339919604849;11065.280756750786;11273.774524509628;11275.887241127484;11398.001856417195 11:41:59 INFO - PROCESS | 14177 | __end_tp_report 11:41:59 INFO - PROCESS | 14177 | __start_cc_report 11:41:59 INFO - PROCESS | 14177 | _x_x_mozilla_cycle_collect,1130 11:41:59 INFO - PROCESS | 14177 | __end_cc_report 11:41:59 INFO - PROCESS | 14177 | __startTimestamp1472668919715__endTimestamp 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | ------- Summary: start ------- 11:41:59 INFO - PROCESS | 14177 | Number of tests: 6 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | [#0] dojo.html Cycles:165 Average:5352.49 Median:5561.08 stddev:605.31 (10.9%) stddev-sans-first:580.35 11:41:59 INFO - PROCESS | 14177 | Values: 3081.1 3091.5 3104.1 3137.9 3165.1 5221.4 5333.6 5375.6 5422.9 5425.5 5423.6 5447.1 5476.0 5513.4 5551.3 4857.5 4886.7 4944.0 4954.3 5023.7 4944.1 4966.8 4969.0 4990.6 4994.1 4819.8 4825.7 4861.5 4862.4 4956.2 4761.9 4884.2 4945.9 4956.3 4968.5 4701.3 4773.0 4777.5 4793.1 4800.3 5311.2 5315.9 5328.5 5329.1 5334.0 5524.3 5647.5 5699.8 5711.5 5717.3 5691.8 5750.6 5756.9 5764.0 5768.6 5356.7 5357.2 5358.3 5359.2 5369.3 5811.5 5885.0 5898.9 5917.2 5981.3 5645.2 5647.6 5660.7 5660.9 5661.7 5660.0 5732.0 5760.3 5773.2 5773.2 5616.1 5677.0 5686.7 5770.5 5781.0 5686.7 5733.7 5734.9 5737.5 5740.8 4404.9 4438.0 4441.5 4444.1 4489.0 3864.4 3895.6 3944.6 3960.9 3992.1 5440.6 5446.2 5449.0 5449.4 5502.9 5740.1 5753.2 5753.2 5753.3 5753.6 5423.7 5426.9 5463.3 5515.1 5531.5 5037.6 5039.0 5043.8 5051.5 5088.6 5972.4 6005.1 6011.4 6013.2 6017.7 5708.7 5727.9 5780.0 5808.1 5945.2 5954.2 5972.3 5973.4 5973.4 6028.1 5669.8 5705.5 5715.2 5718.4 5725.7 5712.6 5778.0 5778.1 5807.7 5860.5 5561.1 5610.5 5612.7 5705.4 5717.0 5581.6 5636.9 5638.2 5642.6 5643.8 5554.8 5572.3 5575.2 5576.0 5581.6 5545.3 5613.4 5651.1 5664.9 5761.2 5523.3 5548.6 5551.7 5554.2 5563.3 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | [#1] ext.html Cycles:180 Average:62395.61 Median:41248.59 stddev:131826.16 (319.6%) stddev-sans-first:132114.28 11:41:59 INFO - PROCESS | 14177 | Values: 586.7 603.9 628.3 638.5 643.1 32235.5 33024.8 43512.8 43595.1 43811.8 40983.0 44661.0 44684.5 44731.8 44784.0 8768.1 8895.0 8896.0 8908.2 8917.1 8954.3 9036.9 9041.2 9047.4 9052.3 9064.6 9100.0 9105.4 9117.4 9120.2 8971.2 9011.8 9012.8 9039.3 9040.0 8948.0 9009.0 9010.7 9020.9 9022.5 42153.8 42461.8 42799.0 42904.4 42918.6 3490.9 3581.5 3626.3 3663.2 3685.7 31939.2 32055.7 32067.2 32331.7 32460.5 4287.2 4360.0 4363.3 4386.5 4458.6 349628.0 351628.0 351881.2 352050.0 352397.0 56680.7 57093.7 57153.4 57210.0 57279.7 36360.8 37204.6 59959.7 60023.0 60091.7 15409.2 15810.9 15871.8 15890.9 15896.1 11620.8 11630.1 11651.0 11660.1 11667.1 18985.4 19064.9 19095.8 19159.2 19175.1 6906.4 7112.8 7113.6 7299.7 7399.4 946.3 1041.7 1086.0 1095.1 1112.9 31526.7 31668.8 31923.8 32250.8 32296.7 925.7 1084.2 1100.8 1120.4 1148.9 15513.7 16603.8 16634.7 16635.4 16920.9 550502.0 557449.0 560409.0 567412.0 884462.0 58318.4 58707.4 58715.7 58756.0 58917.9 1228.0 1289.4 1304.5 1305.1 1340.4 30027.5 32374.7 32427.2 32463.5 32849.3 49020.5 49710.8 49750.5 49824.5 49889.8 445540.0 447071.0 448600.0 448853.0 450102.0 27353.6 27960.0 28107.3 29082.9 29350.9 46956.8 47105.3 48152.3 48671.0 48939.8 38335.4 40428.8 40665.4 41323.2 42383.0 39260.0 39424.6 39601.8 40869.0 41174.0 33389.3 35947.6 37918.4 39656.8 40618.4 33627.3 35497.6 36082.8 36251.8 36320.5 27166.5 27193.2 27264.5 27271.3 27308.3 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | [#2] jquery.html Cycles:180 Average:28367.58 Median:23392.55 stddev:76882.21 (328.7%) stddev-sans-first:77069.19 11:41:59 INFO - PROCESS | 14177 | Values: 387.8 398.2 401.4 404.7 424.0 13146.8 18391.7 20267.8 20361.0 20476.5 19130.5 19237.1 19648.6 19923.8 19957.3 5417.1 5565.7 5570.4 5571.0 5590.9 5719.6 5812.1 5812.5 5812.9 5815.9 4325.1 6251.2 6461.3 6507.4 6613.2 6327.1 6405.6 6515.6 6577.7 6583.5 5770.6 5789.0 5800.7 5800.7 5803.1 22348.8 23465.6 23631.6 23648.5 23868.0 2424.9 2453.9 2565.3 2601.9 2897.4 10233.3 10630.5 14327.9 14543.0 15131.7 1910.4 1957.1 1962.2 1972.7 1999.7 69228.7 69250.0 75561.6 83705.6 85328.1 10949.8 11066.5 11100.2 11274.8 11470.1 16109.1 16136.8 16158.1 16167.1 16205.4 7598.0 7770.5 7884.4 8040.0 8057.0 7188.0 7266.3 7268.4 7487.9 7525.3 4803.6 4813.7 4824.2 4879.2 5017.3 1939.7 1994.9 2039.6 2059.9 2116.5 859.0 879.6 922.6 960.5 1026.8 18722.2 19948.5 19990.6 20151.5 20161.2 900.8 912.9 936.4 961.2 974.4 10444.5 11084.9 11132.4 11132.7 11146.6 461953.0 462494.0 465636.0 466370.0 472423.0 77594.0 94512.5 95796.5 97202.0 98342.5 931.0 959.9 985.8 993.6 994.4 17558.2 17723.0 18204.7 18341.2 18605.8 42460.0 43304.8 44045.6 44080.8 44824.6 54636.5 56283.0 58059.7 58665.7 59021.7 5832.6 6340.6 7462.0 7728.8 7989.2 7879.6 11097.6 11506.7 13474.8 13592.0 11711.9 11918.9 11934.6 11949.5 11989.5 11124.3 11449.8 11797.8 12048.0 12222.6 12089.3 12198.9 12494.0 12674.2 12975.9 8182.5 8208.6 8332.6 8373.5 8498.8 10608.8 12018.4 12028.8 12126.8 12412.1 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | [#3] mootools.html Cycles:180 Average:5955.36 Median:4844.84 stddev:3424.27 (70.7%) stddev-sans-first:3416.57 11:41:59 INFO - PROCESS | 14177 | Values: 1374.7 1456.1 1505.8 1650.0 1767.2 8640.6 9395.5 9398.0 9399.5 9407.9 7804.8 8597.3 8754.5 8816.6 9176.4 2373.3 2401.8 2406.2 2408.0 2409.0 2348.2 2386.6 2417.5 2421.9 2423.7 2397.5 2397.5 2405.3 2419.6 2426.2 2328.1 2338.6 2346.0 2350.9 2375.3 2315.5 2333.6 2335.2 2341.5 2346.2 9129.6 9225.3 9275.4 9292.9 9303.0 5281.3 5422.2 5429.3 5449.3 5451.9 3528.5 3535.4 3582.6 3618.3 3619.4 1155.4 1159.3 1162.6 1187.6 2166.3 12640.5 12730.8 12811.0 12844.0 12855.0 4187.2 4512.8 4588.7 4671.6 4698.2 10006.8 10007.7 10010.0 10013.6 10034.2 5246.9 5269.2 5279.4 5316.2 5320.9 4374.1 4805.8 4883.9 4914.7 4927.5 3948.9 3955.2 4000.5 4033.1 4052.5 1191.3 1220.0 1231.9 1233.7 1243.5 811.2 856.2 899.8 906.0 940.9 5777.5 5817.5 5870.6 5996.7 6016.7 856.1 901.7 927.7 935.9 993.0 3888.4 4015.4 4023.2 4125.1 4205.1 11047.7 11504.3 11508.9 11518.4 11521.7 11367.9 11374.2 11389.5 11398.3 11423.2 8500.4 8611.7 8621.9 8630.8 8638.3 5889.1 5897.0 5949.3 6119.1 6243.0 9917.0 10086.5 10295.3 10299.8 10316.8 10520.7 10543.5 10557.3 10605.8 10684.8 7829.5 7862.1 7924.8 7978.8 8041.6 9043.7 9115.7 9120.9 9125.1 9131.8 7949.4 8069.8 8094.7 8166.0 8355.5 7946.3 7950.8 8053.4 8057.6 8156.5 7240.1 7419.6 7456.7 7519.2 7527.3 4965.9 5124.5 5133.8 5233.9 5357.8 5039.3 5095.4 5108.2 5123.9 5262.5 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | [#4] prototype.html Cycles:180 Average:4489.95 Median:4987.99 stddev:1275.18 (25.6%) stddev-sans-first:1239.89 11:41:59 INFO - PROCESS | 14177 | Values: 327.6 340.6 345.8 346.7 347.7 5356.3 5356.7 5359.1 5371.3 5390.5 5056.9 5106.6 5218.6 5225.7 5335.5 4158.3 4160.5 4176.2 4179.7 4183.0 4167.0 4183.4 4185.4 4194.1 4226.4 3931.5 4061.9 4147.6 4155.9 4157.5 4147.9 4148.7 4152.6 4163.4 4163.8 3710.5 3725.9 3727.8 3743.9 3764.0 5017.4 5122.5 5155.6 5257.6 5258.8 4759.7 4767.2 4769.5 4770.9 4774.5 5467.0 5470.4 5508.3 5510.8 5518.6 3905.5 4037.8 4048.6 4069.6 4076.5 5669.7 5673.2 5686.0 5693.7 5707.7 4170.3 4172.8 4189.8 4204.0 4233.9 4109.6 4272.3 4276.2 4277.7 4278.4 4741.3 4741.8 4753.6 4807.6 4826.7 5494.6 5513.6 5517.3 5555.7 5583.0 1391.8 1446.5 1467.4 1467.4 1490.5 950.8 951.6 954.5 962.2 979.9 4473.7 4697.9 4719.8 4726.2 4755.8 4923.9 4935.5 4945.7 4956.7 4990.4 4704.4 4715.1 4715.4 4728.8 4738.6 2486.5 2641.6 2643.0 2652.6 2660.4 5136.4 5158.9 5160.0 5178.4 5185.4 5061.6 5064.6 5094.7 5101.9 5119.3 4887.1 5034.5 5100.2 5120.7 5130.7 4934.4 4937.7 4948.7 5027.5 5041.4 4974.6 5028.9 5030.2 5038.5 5055.9 4986.3 4989.7 5078.7 5199.2 5210.9 3769.6 3776.2 3790.5 3790.6 3813.8 4977.9 5397.8 5594.2 5632.3 5639.9 5307.8 5486.3 5554.4 5560.5 5562.2 5289.2 5468.3 5474.2 5496.0 5519.0 5461.8 5498.7 5523.4 5533.4 5545.4 5576.7 5608.4 5620.7 5626.6 5629.6 5221.7 5451.7 5486.2 5486.3 5508.3 11:41:59 INFO - PROCESS | 14177 | 11:41:59 INFO - PROCESS | 14177 | [#5] yui.html Cycles:180 Average:20005.06 Median:4602.97 stddev:28091.32 (610.3%) stddev-sans-first:28132.95 11:41:59 INFO - PROCESS | 14177 | Values: 758.0 763.6 782.3 799.0 822.1 15360.8 16156.0 16206.4 16221.3 16292.7 14977.3 15084.6 15098.2 15126.1 15137.3 655.3 764.3 772.3 783.1 783.4 774.9 782.8 783.0 783.2 783.7 828.2 829.9 830.0 830.5 830.6 674.8 811.0 816.5 818.3 824.5 620.2 621.6 621.7 621.8 621.8 14164.6 14272.6 14279.2 14287.2 14309.2 14260.2 14744.3 14895.3 14918.0 14938.2 13361.8 13598.3 13626.3 13631.4 13712.8 4347.3 4358.2 4419.4 4442.5 4597.8 81217.0 82597.6 82874.5 84940.6 85621.1 11637.0 11781.2 11838.6 11924.8 12102.7 19959.5 19972.6 20044.3 20056.2 20080.0 8250.7 8338.1 8418.7 8435.1 8765.5 4459.2 4486.3 4506.8 4608.1 4640.2 3419.7 3514.5 3521.2 3524.0 3525.6 597.8 604.2 621.4 622.7 624.0 606.8 633.4 678.1 711.9 713.1 8981.8 9363.9 9444.3 9805.4 9922.6 660.3 693.1 696.6 724.9 727.2 4294.1 4412.0 4519.5 4540.3 4694.1 66936.7 66967.0 67192.7 98766.5 121954.0 67087.3 86453.6 104650.5 106488.5 111161.0 59692.0 75531.2 89357.0 92384.5 92630.0 8273.9 8294.3 8468.8 8554.8 8586.7 52119.5 52743.7 53019.5 53919.5 54041.1 75792.6 75817.6 76174.0 78437.6 79209.0 11656.0 11795.8 11881.8 12081.2 12286.3 12970.8 12977.4 13186.1 13696.5 13761.2 13181.8 13594.3 13681.4 13792.5 14008.1 14058.5 14342.9 14516.9 14520.3 15048.2 13276.6 13467.6 13601.2 14238.2 14518.6 10449.3 10531.8 11406.4 11427.8 11662.8 11001.3 11065.3 11273.8 11275.9 11398.0 11:41:59 INFO - PROCESS | 14177 | -------- Summary: end -------- 11:41:59 INFO - PROCESS | 14177 | 11:42:00 INFO - TEST-INFO | 14177: exit 0 11:42:00 INFO - TEST-OK | dromaeo_css | took 1115541ms 11:42:00 INFO - TEST-START | kraken 11:42:00 INFO - operating with platform_type : linux_ 11:42:00 INFO - Initialising browser for kraken test... 11:42:00 INFO - TEST-INFO | started process 14488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrBmFO/profile http://localhost:38646/getInfo.html) 11:42:04 INFO - PROCESS | 14488 | __metrics Screen width/height:1600/1200 11:42:04 INFO - PROCESS | 14488 | colorDepth:24 11:42:04 INFO - PROCESS | 14488 | Browser inner width/height: 1024/697 11:42:04 INFO - PROCESS | 14488 | __metrics 11:42:04 INFO - PROCESS | 14488 | 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" 11:42:04 INFO - PROCESS | 14488 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:42:05 INFO - PROCESS | 14488 | console.error: PushService: 11:42:05 INFO - PROCESS | 14488 | stateChangeProcessEnqueue: Error transitioning state 11:42:05 INFO - PROCESS | 14488 | UnknownError 11:42:05 INFO - TEST-INFO | 14488: exit 0 11:42:05 INFO - Browser initialized. 11:42:05 INFO - Running cycle 1/1 for kraken test... 11:42:05 INFO - TEST-INFO | started process 14569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrBmFO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:17 INFO - PROCESS | 14569 | RSS: Main: 180543488 11:42:17 INFO - PROCESS | 14569 | 11:42:20 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38646/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:21 INFO - PROCESS | 14569 | RSS: Main: 233664512 11:42:21 INFO - PROCESS | 14569 | 11:42:23 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38646/tests/kraken/driver.html?testName=audio-dft) 11:42:24 INFO - PROCESS | 14569 | RSS: Main: 224432128 11:42:24 INFO - PROCESS | 14569 | 11:42:27 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38646/tests/kraken/driver.html?testName=audio-fft) 11:42:28 INFO - PROCESS | 14569 | RSS: Main: 299864064 11:42:28 INFO - PROCESS | 14569 | 11:42:30 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38646/tests/kraken/driver.html?testName=audio-oscillator) 11:42:30 INFO - PROCESS | 14569 | RSS: Main: 211202048 11:42:30 INFO - PROCESS | 14569 | 11:42:32 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:33 INFO - PROCESS | 14569 | RSS: Main: 213065728 11:42:33 INFO - PROCESS | 14569 | 11:42:36 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38646/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:37 INFO - PROCESS | 14569 | RSS: Main: 251670528 11:42:37 INFO - PROCESS | 14569 | 11:42:40 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38646/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:41 INFO - PROCESS | 14569 | RSS: Main: 251121664 11:42:41 INFO - PROCESS | 14569 | 11:42:43 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38646/tests/kraken/driver.html?testName=json-parse-financial) 11:42:44 INFO - PROCESS | 14569 | RSS: Main: 251379712 11:42:44 INFO - PROCESS | 14569 | 11:42:46 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:46 INFO - PROCESS | 14569 | RSS: Main: 213737472 11:42:46 INFO - PROCESS | 14569 | 11:42:48 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:49 INFO - PROCESS | 14569 | RSS: Main: 222326784 11:42:49 INFO - PROCESS | 14569 | 11:42:51 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:51 INFO - PROCESS | 14569 | RSS: Main: 221802496 11:42:51 INFO - PROCESS | 14569 | 11:42:54 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:54 INFO - PROCESS | 14569 | RSS: Main: 223129600 11:42:54 INFO - PROCESS | 14569 | 11:42:57 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:58 INFO - PROCESS | 14569 | RSS: Main: 220545024 11:42:58 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | Cycle 1(1): loaded http://localhost:38646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38646/tests/kraken/driver.html?testName=ai-astar) 11:43:00 INFO - PROCESS | 14569 | RSS: Main: 272072704 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | __start_tp_report 11:43:00 INFO - PROCESS | 14569 | _x_x_mozilla_page_load 11:43:00 INFO - PROCESS | 14569 | _x_x_mozilla_page_load_details 11:43:00 INFO - PROCESS | 14569 | |i|pagename|runs| 11:43:00 INFO - PROCESS | 14569 | |0;ai-astar;111;109;129;111;111;109;110;114;112;114 11:43:00 INFO - PROCESS | 14569 | |1;audio-beat-detection;146;115;141;173;123;146;143;121;179;116 11:43:00 INFO - PROCESS | 14569 | |2;audio-dft;163;160;160;159;160;164;164;160;160;159 11:43:00 INFO - PROCESS | 14569 | |3;audio-fft;75;74;74;181;76;75;75;77;163;76 11:43:00 INFO - PROCESS | 14569 | |4;audio-oscillator;82;81;137;82;82;83;147;82;81;156 11:43:00 INFO - PROCESS | 14569 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;118;118 11:43:00 INFO - PROCESS | 14569 | |6;imaging-darkroom;146;145;146;146;145;146;145;146;145;146 11:43:00 INFO - PROCESS | 14569 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:43:00 INFO - PROCESS | 14569 | |8;json-parse-financial;51;52;53;52;54;52;52;52;52;52 11:43:00 INFO - PROCESS | 14569 | |9;json-stringify-tinderbox;63;62;62;63;62;62;65;62;63;63 11:43:00 INFO - PROCESS | 14569 | |10;stanford-crypto-aes;80;87;78;79;79;78;79;85;78;79 11:43:00 INFO - PROCESS | 14569 | |11;stanford-crypto-ccm;126;127;129;125;125;135;122;137;167;137 11:43:00 INFO - PROCESS | 14569 | |12;stanford-crypto-pbkdf2;163;164;160;162;161;163;161;161;163;162 11:43:00 INFO - PROCESS | 14569 | |13;stanford-crypto-sha256-iterative;67;70;66;64;65;66;64;66;63;63 11:43:00 INFO - PROCESS | 14569 | __end_tp_report 11:43:00 INFO - PROCESS | 14569 | __start_cc_report 11:43:00 INFO - PROCESS | 14569 | _x_x_mozilla_cycle_collect,1728 11:43:00 INFO - PROCESS | 14569 | __end_cc_report 11:43:00 INFO - PROCESS | 14569 | __startTimestamp1472668980281__endTimestamp 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | ------- Summary: start ------- 11:43:00 INFO - PROCESS | 14569 | Number of tests: 14 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#0] ai-astar Cycles:10 Average:113.00 Median:111.50 stddev:5.89 (5.3%) stddev-sans-first:6.20 11:43:00 INFO - PROCESS | 14569 | Values: 111.0 109.0 129.0 111.0 111.0 109.0 110.0 114.0 112.0 114.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:144.50 stddev:22.47 (15.5%) stddev-sans-first:23.73 11:43:00 INFO - PROCESS | 14569 | Values: 146.0 115.0 141.0 173.0 123.0 146.0 143.0 121.0 179.0 116.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#2] audio-dft Cycles:10 Average:160.90 Median:160.00 stddev:1.97 (1.2%) stddev-sans-first:1.94 11:43:00 INFO - PROCESS | 14569 | Values: 163.0 160.0 160.0 159.0 160.0 164.0 164.0 160.0 160.0 159.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:41.02 (54.7%) stddev-sans-first:42.89 11:43:00 INFO - PROCESS | 14569 | Values: 75.0 74.0 74.0 181.0 76.0 75.0 75.0 77.0 163.0 76.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:82.00 stddev:31.63 (38.6%) stddev-sans-first:32.77 11:43:00 INFO - PROCESS | 14569 | Values: 82.0 81.0 137.0 82.0 82.0 83.0 147.0 82.0 81.0 156.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 11:43:00 INFO - PROCESS | 14569 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 118.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:43:00 INFO - PROCESS | 14569 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:43:00 INFO - PROCESS | 14569 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.79 (1.5%) stddev-sans-first:0.71 11:43:00 INFO - PROCESS | 14569 | Values: 51.0 52.0 53.0 52.0 54.0 52.0 52.0 52.0 52.0 52.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 11:43:00 INFO - PROCESS | 14569 | Values: 63.0 62.0 62.0 63.0 62.0 62.0 65.0 62.0 63.0 63.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.00 stddev:3.16 (4.0%) stddev-sans-first:3.35 11:43:00 INFO - PROCESS | 14569 | Values: 80.0 87.0 78.0 79.0 79.0 78.0 79.0 85.0 78.0 79.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:132.00 stddev:13.09 (9.9%) stddev-sans-first:13.64 11:43:00 INFO - PROCESS | 14569 | Values: 126.0 127.0 129.0 125.0 125.0 135.0 122.0 137.0 167.0 137.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 11:43:00 INFO - PROCESS | 14569 | Values: 163.0 164.0 160.0 162.0 161.0 163.0 161.0 161.0 163.0 162.0 11:43:00 INFO - PROCESS | 14569 | 11:43:00 INFO - PROCESS | 14569 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:2.12 (3.2%) stddev-sans-first:2.17 11:43:00 INFO - PROCESS | 14569 | Values: 67.0 70.0 66.0 64.0 65.0 66.0 64.0 66.0 63.0 63.0 11:43:00 INFO - PROCESS | 14569 | -------- Summary: end -------- 11:43:00 INFO - PROCESS | 14569 | 11:43:01 INFO - TEST-INFO | 14569: exit 0 11:43:01 INFO - TEST-OK | kraken | took 60827ms 11:43:01 INFO - SUITE-END | took 1176s 11:43:01 INFO - Completed test suite (00:19:36) 11:43:01 INFO - javascript benchmark 11:43:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.0602766156326, 3091.4744493436115, 3104.068779366191, 3137.8744850205994, 3165.129589362925, 5221.373435187783, 5333.573314134869, 5375.623706340558, 5422.945770542294, 5425.5117039466395, 5423.620346575742, 5447.073997420438, 5476.0, 5513.365962914276, 5551.250581171541, 4857.465678775332, 4886.706797592155, 4944.0, 4954.2568614707725, 5023.723695196781, 4944.110060189165, 4966.776495057731, 4968.950310496903, 4990.625703072266, 4994.051130285252, 4819.759012049419, 4825.745306220408, 4861.538153875376, 4862.3922009748785, 4956.2070068789, 4761.880952976168, 4884.19410797218, 4945.851624451272, 4956.306117143603, 4968.527989840959, 4701.341812146302, 4773.021530586221, 4777.546133117348, 4793.089313030548, 4800.255960326155, 5311.176767601028, 5315.893682126374, 5328.46715328468, 5329.094054010828, 5334.03987282289, 5524.309461317335, 5647.548196144298, 5699.772009119631, 5711.543076553866, 5717.313922329306, 5691.7723291068305, 5750.6262092963825, 5756.942430575725, 5763.971180144073, 5768.625039372428, 5356.651817631841, 5357.223202635596, 5358.303420555303, 5359.196120581866, 5369.301990741257, 5811.506021988093, 5884.9705751470965, 5898.852528686732, 5917.171595976567, 5981.282246130492, 5645.153227015899, 5647.604667673306, 5660.716964151776, 5660.8867822643315, 5661.716914154358, 5660.037793575102, 5732.0255556555485, 5760.337561180434, 5773.162891380726, 5773.191753154561, 5616.101423772258, 5676.971615141981, 5686.687232202268, 5770.480656740913, 5781.046127388934, 5686.687232202268, 5733.655980641175, 5734.913976290359, 5737.454941780524, 5740.827775166752, 4404.911901761947, 4438.0, 4441.489228738672, 4444.1111777643955, 4488.977555112204, 3864.42033694948, 3895.552011518655, 3944.625260600296, 3960.9009774755286, 3992.061865461614, 5440.591955603267, 5446.2375267462585, 5448.972755136199, 5449.373322067933, 5502.9174562381595, 5740.13897915316, 5753.165790960287, 5753.165790960371, 5753.252077229933, 5753.597248192586, 5423.701696406735, 5426.864328391822, 5463.344398672105, 5515.090010148361, 5531.502164805187, 5037.571806396498, 5038.974805126024, 5043.773030213649, 5051.4695956924, 5088.592912566985, 5972.40275972408, 6005.129256257818, 6011.428914253139, 6013.188219590387, 6017.6938310428495, 5708.743106560298, 5727.8854422912145, 5780.0173970424285, 5808.099744539603, 5945.19739835134, 5954.166416701752, 5972.283326000907, 5973.402659733992, 5973.432523910222, 6028.125921741235, 5669.801556945487, 5705.486506214461, 5715.228444159985, 5718.428157184415, 5725.6850873202375, 5712.571557133315, 5777.971110144423, 5778.133280007864, 5807.651540907559, 5860.531157507475, 5561.082421400585, 5610.5231055360755, 5612.7193640317, 5705.429457054262, 5717.0, 5581.637193582566, 5636.88726225465, 5638.23883775685, 5642.605017648725, 5643.802466913638, 5554.777808887599, 5572.331320241435, 5575.247341608993, 5575.972120139373, 5581.553475721851, 5545.334559852843, 5613.382527921844, 5651.124075768263, 5664.886702266014, 5761.164631128547, 5523.337199536081, 5548.55611551083, 5551.694656793915, 5554.222408862682, 5563.332400112013], "value": 5311.645566150002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7066466766616, 603.8550747820523, 628.2774808969688, 638.4860187549021, 643.0739734781914, 32235.51646725298, 33024.83487582562, 43512.782436087815, 43595.07644312011, 43811.78094109533, 40983.0, 44661.0, 44684.53154684538, 44731.77634111833, 44784.0, 8768.079351668062, 8895.021547629756, 8895.95552022239, 8908.153725396109, 8917.063708310632, 8954.2836573074, 9036.909630903672, 9041.231495322905, 9047.366684332099, 9052.27581793455, 9064.592093355783, 9100.0, 9105.36262461628, 9117.361784675075, 9120.17918387345, 8971.237444817132, 9011.774705632379, 9012.819743605123, 9039.276857851357, 9040.0, 8947.955260223722, 9008.954955225248, 9010.729678109667, 9020.909790902138, 9022.50376229307, 42153.78923105365, 42461.787691061654, 42799.0, 42904.356434653506, 42918.57081429177, 3490.9127271818406, 3581.5344005279408, 3626.3291291111227, 3663.19409729859, 3685.668289853926, 31939.201519961953, 32055.679443205503, 32067.198320042186, 32331.6766832331, 32460.513092303634, 4287.228298906196, 4360.0, 4363.3018717005125, 4386.495553011413, 4458.598726114666, 349628.0, 351628.0, 351881.24059379793, 352050.0, 352397.0, 56680.71659641675, 57093.714531427075, 57153.428465715646, 57210.0, 57279.71360143173, 36360.818195908854, 37204.62795372012, 59959.70020149959, 60023.0, 60091.69954150289, 15409.152496612794, 15810.92094539543, 15871.761923571155, 15890.920545397199, 15896.12571308566, 11620.767584648429, 11630.069594432425, 11651.00966417864, 11660.06719462441, 11667.066634669207, 18985.43043708691, 19064.904675476533, 19095.809041909404, 19159.233630654897, 19175.137118829687, 6906.412954898789, 7112.822179445452, 7113.597762014125, 7299.744508942162, 7399.445041621792, 946.2902822882838, 1041.7135287795766, 1085.9944506876982, 1095.1457862866976, 1112.872019717743, 31526.684733152833, 31668.841655791573, 31923.84038079795, 32250.838745806122, 32296.677033229837, 925.7222833150028, 1084.219362059316, 1100.8128618134936, 1120.4005856866538, 1148.8506494155706, 15513.681337086475, 16603.750943735853, 16634.6673066538, 16635.419635134644, 16920.91539542319, 550502.0, 557449.0, 560409.0, 567412.0, 884462.0, 58318.41681583215, 58707.412925871045, 58715.70642146762, 58756.0, 58917.93787217427, 1228.0482625964771, 1289.374653293152, 1304.523848795202, 1305.092960392518, 1340.4102195034154, 30027.549586756653, 32374.676253237165, 32427.18932026624, 32463.513047303837, 32849.34301314008, 49020.529384118534, 49710.75144624254, 49750.502494974586, 49824.50175498199, 49889.75055124701, 445540.0, 447071.0, 448600.0, 448853.0, 450102.0, 27353.589696154973, 27960.0, 28107.297317567223, 29082.854585726935, 29350.853245733633, 46956.7652161737, 47105.2934205994, 48152.27771583499, 48671.0, 48939.75530122327, 38335.42496862605, 40428.79785601053, 40665.39001914914, 41323.1735365297, 42383.0, 39260.0, 39424.605753943244, 39601.80199098986, 40869.0, 41174.0, 33389.33221335511, 35947.64052359547, 37918.43122353222, 39656.801715991234, 40618.390724139754, 33627.32745345031, 35497.5979406639, 36082.8195859019, 36251.81874090718, 36320.45519317265, 27166.456670866868, 27193.1842044739, 27264.454710905273, 27271.318217044733, 27308.31729206786], "value": 19897.863374963457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.7867173054819, 398.2254514968388, 401.3578274760384, 404.7470331043098, 423.96608271338295, 13146.816786489215, 18391.72412413815, 20267.797322026792, 20361.0, 20476.488087797814, 19130.521736956583, 19237.134328955195, 19648.607027859434, 19923.800761992377, 19957.301494447696, 5417.079096553585, 5565.749541270652, 5570.415106413829, 5570.972145139269, 5590.86022849428, 5719.628224165437, 5812.070068788995, 5812.534997200235, 5812.854678633047, 5815.854603634922, 4325.091730736549, 6251.218597675291, 6461.321561236073, 6507.4143327100555, 6613.239477460105, 6327.133495618804, 6405.583637063576, 6515.609063456208, 6577.7368905243975, 6583.473322134242, 5770.596058275923, 5789.0, 5800.709964501801, 5800.738966746507, 5803.071508558611, 22348.776512234996, 23465.648015279785, 23631.645525317133, 23648.527029459485, 23868.0, 2424.866632335221, 2453.865037422941, 2565.307367010915, 2601.8829152688177, 2897.4060317635044, 10233.334833235816, 10630.46847657614, 14327.856721432756, 14543.0, 15131.697366052727, 1910.3791267838008, 1957.1290775604862, 1962.1856929374292, 1972.7336809530816, 1999.6700544410155, 69228.6538567309, 69250.0, 75561.62219188924, 83705.58147209286, 85328.14671853326, 10949.781004379867, 11066.502007409686, 11100.222984391177, 11274.830877536844, 11470.139739519569, 16109.113998729948, 16136.75794863078, 16158.111303878399, 16167.110808905389, 16205.432809851598, 7597.962010189914, 7770.456068075294, 7884.369250459949, 8040.0, 8056.959715201387, 7187.9640601796655, 7266.309700578437, 7268.418526517866, 7487.925120748831, 7525.285097915689, 4803.639727020487, 4813.7352445615825, 4824.155772739757, 4879.243717223836, 5017.272495488134, 1939.7478327817294, 1994.9102290396968, 2039.567611666316, 2059.929770580587, 2116.47088227943, 858.9957050214709, 879.569011184515, 922.6401703335705, 960.4765402855321, 1026.7946410717886, 18722.157502912403, 19948.50128746793, 19990.60018799645, 20151.49621259451, 20161.193552257744, 900.7658008917729, 912.8721978922956, 936.3960245641523, 961.2310151878469, 974.3666616699061, 10444.529996150039, 11084.889151108548, 11132.38771867555, 11132.721681957853, 11146.609868654721, 461953.0, 462494.0, 465636.0, 466370.0, 472423.0, 77594.0, 94512.52743736237, 95796.52101739447, 97202.0, 98342.50828745954, 930.9860352094724, 959.8896126945351, 985.7634167799677, 993.5826952679892, 994.3884511025811, 17558.20988055566, 17723.0, 18204.72692909581, 18341.174647140644, 18605.81394186095, 42460.0, 43304.78347608368, 44045.55954440415, 44080.77959610181, 44824.55175448334, 54636.453635463135, 56283.0, 58059.709701451226, 58665.70667146808, 59021.671207539366, 5832.62087964281, 6340.556161068681, 7461.955326254438, 7728.845423091394, 7989.161138080418, 7879.644003414387, 11097.611583594535, 11506.712332191428, 13474.797878032034, 13592.0, 11711.941440292743, 11918.940405297919, 11934.641960741192, 11949.462274197507, 11989.460474278852, 11124.276922000045, 11449.828252576384, 11797.76404471923, 12047.975922046724, 12222.572209972608, 12089.274643521418, 12198.939005304917, 12494.0, 12674.176178548365, 12975.935120324339, 8182.509049457051, 8208.58957052157, 8332.625031873702, 8373.539455330016, 8498.830023399621, 10608.840867387149, 12018.399080046138, 12028.819567706667, 12126.75746485083, 12412.069094817743], "value": 9271.572994974624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.6700791809965, 1456.1263242054765, 1505.8042454480915, 1649.983500164998, 1767.2400867626923, 8640.567971601418, 9395.530223488833, 9397.953010234947, 9399.483028433433, 9407.905920940797, 7804.765857024284, 8597.269232115263, 8754.518501482416, 8816.603252853622, 9176.449413035205, 2373.32360277321, 2401.7838394544488, 2406.242033759369, 2407.963880541793, 2408.9638655420094, 2348.1781376518165, 2386.59427897257, 2417.4560723837085, 2421.891014904325, 2423.72127205371, 2397.460571371445, 2397.4845408237225, 2405.3385319037316, 2419.5765740995344, 2426.1751004658413, 2328.1269523928527, 2338.6141286687675, 2346.0263990443946, 2350.905963761456, 2375.263668262844, 2315.5253173099472, 2333.556624241389, 2335.1710142899196, 2341.484873327865, 2346.155384061736, 9129.589168487433, 9225.308101892386, 9275.443473391551, 9292.907070929272, 9302.953485232598, 5281.287026251483, 5422.186671999192, 5429.348478182604, 5449.291592093042, 5451.945480545223, 3528.523649307336, 3535.3636345457808, 3582.6417358264225, 3618.348697234523, 3619.438986957026, 1155.4280631087581, 1159.2928313728619, 1162.6047143971007, 1187.584345479084, 2166.3176099528755, 12640.49438022478, 12730.80903786444, 12811.0, 12843.999999999907, 12855.0, 4187.183499217624, 4512.751798651106, 4588.724676519353, 4671.6262698984, 4698.201305778026, 10006.848527566608, 10007.699769006942, 10010.0, 10013.599456021822, 10034.197264218845, 5246.947530524722, 5269.235960785664, 5279.419263881046, 5316.229146773696, 5320.920186197211, 4374.081442897027, 4805.831795887197, 4883.853484395474, 4914.655974081851, 4927.507249275044, 3948.9210215795524, 3955.2287303976022, 4000.5399379071196, 4033.072393349546, 4052.4731784867777, 1191.3090407563593, 1220.0113814482338, 1231.9199252048588, 1233.747081848219, 1243.4963839644959, 811.2131232704268, 856.1805221411487, 899.7615631857562, 906.0, 940.9200217981548, 5777.45114214149, 5817.505512031525, 5870.618409803349, 5996.67018313997, 6016.69916504173, 856.1181982557976, 901.724973882972, 927.7402327348353, 935.9485228312508, 993.0417147452742, 3888.416737489399, 4015.437838702584, 4023.1752490739327, 4125.133721918371, 4205.095904380573, 11047.72380690489, 11504.252223605607, 11508.88491115078, 11518.36648984314, 11521.654350369503, 11367.886321136848, 11374.20380573352, 11389.544418223179, 11398.316101033799, 11423.200375973769, 8500.362472814564, 8611.698590549426, 8621.91378086211, 8630.78423039429, 8638.308935285162, 5889.087191485327, 5896.970515147568, 5949.345571986992, 6119.082137679384, 6242.975781988092, 9917.0, 10086.495675216356, 10295.279330447096, 10299.794004120025, 10316.793664126826, 10520.736981575521, 10543.525541350811, 10557.260991730505, 10605.787884242427, 10684.83972740425, 7829.5302281860995, 7862.135165131716, 7924.762257132295, 7978.800529986796, 8041.597920103854, 9043.728688139367, 9115.726528204164, 9120.908790912272, 9125.087491250822, 9131.817363652823, 7949.443538952449, 8069.83860322802, 8094.676212951416, 8166.032018182237, 8355.540445275568, 7946.284834364935, 7950.761477155695, 8053.35573154158, 8057.637406316612, 8156.469829461066, 7240.05879235696, 7419.591922444318, 7456.7390141344795, 7519.248075192656, 7527.2849079337375, 4965.900681986268, 5124.461931497288, 5133.7689803958165, 5233.921491177559, 5357.785688572413, 5039.294498770102, 5095.414027386898, 5108.182690769459, 5123.872747995435, 5262.526492582083], "value": 4742.268859218944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5772406720679, 340.6236109099445, 345.79252448530883, 346.7139609821896, 347.67145047929716, 5356.303680521536, 5356.705381204032, 5359.142537194045, 5371.328583927009, 5390.51485366317, 5056.898862022757, 5106.64253502255, 5218.556422704075, 5225.738713064341, 5335.493128152819, 4158.293090174662, 4160.542340342575, 4176.18564379946, 4179.686523510733, 4183.0, 4167.020665184028, 4183.435236243114, 4185.434966279559, 4194.119234960646, 4226.429432026668, 3931.4889064421727, 4061.8578349757763, 4147.5645057269, 4155.916881662365, 4157.521884983235, 4147.8963025924295, 4148.668106551499, 4152.626263636287, 4163.437935878663, 4163.770992595406, 3710.4990826238654, 3725.8695945642044, 3727.7949712765785, 3743.9142648631864, 3764.0213544478634, 5017.437619290308, 5122.462141475166, 5155.561777248939, 5257.579393648537, 5258.842234732926, 4759.667293157921, 4767.165745994437, 4769.546893045155, 4770.904581908342, 4774.543764151932, 5467.0, 5470.398256191816, 5508.338999320067, 5510.752016159242, 5518.558515318765, 3905.4839046874745, 4037.798110094513, 4048.5748996355255, 4069.633732964018, 4076.5324483186027, 5669.744861481243, 5673.177389278573, 5686.0, 5693.715314234271, 5707.686077265748, 4170.332746760564, 4172.7913604319665, 4189.790510474464, 4203.978980105141, 4233.872983810491, 4109.568495308009, 4272.29507131326, 4276.166147601188, 4277.732801615149, 4278.4010238566625, 4741.312509686076, 4741.83403580873, 4753.621449779525, 4807.567318941312, 4826.734529600835, 5494.560435165257, 5513.58648101394, 5517.282753242052, 5555.666660000413, 5582.972085139549, 1391.8190635217356, 1446.5443385333585, 1467.3543640798014, 1467.3763650448516, 1490.4559835659907, 950.8431108867098, 951.5765484359532, 954.5131982688879, 962.167724917941, 979.8530220466987, 4473.731576105444, 4697.929531057037, 4719.834805781781, 4726.220173671374, 4755.83354582588, 4923.9167383175645, 4935.531124543163, 4945.703257804544, 4956.702597844141, 4990.426100998432, 4704.435467743892, 4715.127701375257, 4715.434147902273, 4728.763561821964, 4738.597219236403, 2486.490269494749, 2641.564141916601, 2643.035292118363, 2652.6418933444124, 2660.388110734542, 5136.383633963948, 5158.871028224325, 5159.968006398735, 5178.352705911761, 5185.377754669464, 5061.569766569883, 5064.569511591556, 5094.745262736848, 5101.897962040738, 5119.312361010425, 4887.095887260868, 5034.546890779848, 5100.209467532539, 5120.692758434506, 5130.692158470354, 4934.358533390637, 4937.728424936519, 4948.713334532976, 5027.50038715355, 5041.395032596112, 4974.602031837517, 5028.874278142929, 5030.220315851049, 5038.521340472649, 5055.898882022266, 4986.301917731593, 4989.675671081368, 5078.7206703631655, 5199.2184181462735, 5210.869728256824, 3769.5696915806484, 3776.2258736959407, 3790.469334293146, 3790.6019867913474, 3813.8093095344566, 4977.900441991067, 5397.757100930546, 5594.216809646734, 5632.295963004624, 5639.8590035249445, 5307.840764777063, 5486.341639003345, 5554.416786237387, 5560.498665360249, 5562.249096371938, 5289.233061206027, 5468.332158691637, 5474.206240095244, 5495.972520137374, 5519.0, 5461.836144915659, 5498.697571633438, 5523.4200408956485, 5533.446655334435, 5545.3622833373065, 5576.721163941867, 5608.4111168326735, 5620.718964051863, 5626.578006649435, 5629.577781666309, 5221.712805795718, 5451.672899626035, 5486.204500347507, 5486.31421072366, 5508.3114610673665], "value": 4092.9741488112873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.9583122928238, 763.564768082193, 782.2920257167262, 799.0451410564374, 822.0966928167942, 15360.84639153608, 16156.0, 16206.351745930178, 16221.270042848086, 16292.674146517062, 14977.326020329085, 15084.622884427894, 15098.245087745596, 15126.092434453913, 15137.31882065307, 655.302103260029, 764.3044829205425, 772.289493665826, 783.0681489028067, 783.4241832253289, 774.9496282741632, 782.8160382310152, 782.9608519574027, 783.1541934710499, 783.7178615698344, 828.1676914700718, 829.8796674482196, 829.9751007469786, 830.5182993863544, 830.5805568188086, 674.7638326585704, 810.9756707298791, 816.4692949582759, 818.3085292927497, 824.4640983360804, 620.2185246589285, 621.5649045668006, 621.6767281013892, 621.7885918787634, 621.8227805075577, 14164.645883852883, 14272.643183920381, 14279.21464319462, 14287.214203218819, 14309.212993285366, 14260.215688137148, 14744.336504857307, 14895.329710163069, 14918.0, 14938.178400187986, 13361.799573006412, 13598.252096134709, 13626.318684065856, 13631.386587603582, 13712.794308085387, 4347.260965635849, 4358.150160718661, 4419.359192917009, 4442.511323754385, 4597.793099310539, 81217.0, 82597.58701206456, 82874.49696303184, 84940.57529712374, 85621.14378856194, 11637.0, 11781.175317727677, 11838.644840654793, 11924.76150477003, 12102.697432564257, 19959.501012474804, 19972.600547988957, 20044.298449554197, 20056.197752089753, 20080.0, 8250.669973201126, 8338.124496927736, 8418.747437576883, 8435.11431299717, 8765.517896515752, 4459.241928872099, 4486.282194848808, 4506.797194126272, 4608.1474927137915, 4640.23436133041, 3419.692227699469, 3514.5431093957623, 3521.2429327694667, 3524.048506903122, 3525.6121826599056, 597.8027251007157, 604.2175382879094, 621.4034526854181, 622.7135517661835, 623.9500839932795, 606.7815586388897, 633.398271641942, 678.1218322272669, 711.921688614252, 713.1264201353405, 8981.820363592822, 9363.859542106873, 9444.338896277332, 9805.362651427635, 9922.553485093189, 660.3495556876472, 693.1197379328225, 696.6377483708443, 724.8695234857777, 727.2146082231178, 4294.1220293525785, 4411.9558804411545, 4519.502854685982, 4540.250858608359, 4694.131585656596, 66936.66531667407, 66967.0, 67192.6640366795, 98766.5061674687, 121954.0, 67087.32912670908, 86453.56773216094, 104650.47674761577, 106488.46755766172, 111161.0, 59692.0, 75531.24468755242, 89357.0, 92384.53807730919, 92630.0, 8273.875891861506, 8294.294984926108, 8468.788280293042, 8554.828903422022, 8586.699465518677, 52119.47880521146, 52743.73628131835, 53019.46980530145, 53919.46080539301, 54041.10856120017, 75792.62103689446, 75817.62091189729, 76174.0, 78437.60781196058, 79209.0, 11656.0, 11795.764084718428, 11881.82177267359, 12081.214721043105, 12286.262824230575, 12970.805437918627, 12977.35113244353, 13186.142900711424, 13696.452141914211, 13761.211042564402, 13181.80227296572, 13594.252316122709, 13681.384337705027, 13792.517261895786, 14008.089474184146, 14058.507952221624, 14342.928285358506, 14516.927415362856, 14520.273986300854, 15048.247587620357, 13276.60170194857, 13467.595972120853, 13601.183928964294, 14238.216898070292, 14518.63703407381, 10449.320794148356, 10531.78936421252, 11406.362173536329, 11427.828582571434, 11662.76674466489, 11001.339919604849, 11065.280756750786, 11273.774524509628, 11275.887241127484, 11398.001856417195], "value": 7435.817105817977, "unit": "score"}], "name": "dromaeo_css", "value": 7218.241200398748, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 129.0, 111.0, 111.0, 109.0, 110.0, 114.0, 112.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 141.0, 173.0, 123.0, 146.0, 143.0, 121.0, 179.0, 116.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 159.0, 160.0, 164.0, 164.0, 160.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 181.0, 76.0, 75.0, 75.0, 77.0, 163.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 137.0, 82.0, 82.0, 83.0, 147.0, 82.0, 81.0, 156.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 52.0, 54.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 65.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 78.0, 79.0, 79.0, 78.0, 79.0, 85.0, 78.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 129.0, 125.0, 125.0, 135.0, 122.0, 137.0, 167.0, 137.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 160.0, 162.0, 161.0, 163.0, 161.0, 161.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 66.0, 64.0, 65.0, 66.0, 64.0, 66.0, 63.0, 63.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1523.1000000000001, "alertThreshold": 2.0}]} 11:43:02 INFO - Return code: 0 11:43:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:43:02 INFO - # TBPL SUCCESS # 11:43:02 INFO - Running post-action listener: _resource_record_post_action 11:43:02 INFO - [mozharness: 2016-08-31 18:43:02.108304Z] Finished run-tests step (success) 11:43:02 INFO - Running post-run listener: _resource_record_post_run 11:43:02 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 413593600; Read time: 0; Write time: 334348 11:43:02 INFO - TinderboxPrint: CPU usage
13.1% 11:43:02 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:43:02 INFO - TinderboxPrint: I/O write bytes / time
413,593,600 / 334,348 11:43:02 INFO - TinderboxPrint: CPU idle
8,274.6 (86.8%) 11:43:02 INFO - TinderboxPrint: CPU user
1,203.7 (12.6%) 11:43:02 INFO - TinderboxPrint: Swap in / out
0 / 0 11:43:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 122863616; Read time: 0; Write time: 126612 11:43:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 290729984; Read time: 0; Write time: 207736 11:43:02 INFO - Running post-run listener: _upload_blobber_files 11:43:02 INFO - Blob upload gear active. 11:43:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:43:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:43:03 INFO - (blobuploader) - INFO - Open directory for files ... 11:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:03 INFO - (blobuploader) - INFO - Done attempting. 11:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:08 INFO - (blobuploader) - INFO - Done attempting. 11:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:09 INFO - (blobuploader) - INFO - Done attempting. 11:43:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:43:09 INFO - Return code: 0 11:43:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:43:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:43:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ffd174bfdf9ed49fe67636206ffa1a5ecd38653600239a2cb072412c2ae951a4107612774bf72e1bb49c8857e59cc4f0d54bbef5a00876b03b707f21d0a4b6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8589dd54a25eaba1ff5ba6b6ff70fabd2544df6585deb94613ebedb5ae901969fe1840f7b80fdd42a98be1670ed5a1b6fa3d5ed31fd5875bb30bb6ed5587cd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6176e1de87dfb83de635463fff648cff59009264082efd18861082871ec52b95f9dffd383786bca4bf045ef72df200c5fda9ebd332d144151cced3adac270fc2"} 11:43:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:43:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:43:09 INFO - Contents: 11:43:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ffd174bfdf9ed49fe67636206ffa1a5ecd38653600239a2cb072412c2ae951a4107612774bf72e1bb49c8857e59cc4f0d54bbef5a00876b03b707f21d0a4b6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8589dd54a25eaba1ff5ba6b6ff70fabd2544df6585deb94613ebedb5ae901969fe1840f7b80fdd42a98be1670ed5a1b6fa3d5ed31fd5875bb30bb6ed5587cd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6176e1de87dfb83de635463fff648cff59009264082efd18861082871ec52b95f9dffd383786bca4bf045ef72df200c5fda9ebd332d144151cced3adac270fc2"} 11:43:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:43:09 INFO - Copying logs to upload dir... 11:43:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:43:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.045896 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-31 11:43:08.285284) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:43:08.289180) ========= 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=923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ffd174bfdf9ed49fe67636206ffa1a5ecd38653600239a2cb072412c2ae951a4107612774bf72e1bb49c8857e59cc4f0d54bbef5a00876b03b707f21d0a4b6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8589dd54a25eaba1ff5ba6b6ff70fabd2544df6585deb94613ebedb5ae901969fe1840f7b80fdd42a98be1670ed5a1b6fa3d5ed31fd5875bb30bb6ed5587cd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6176e1de87dfb83de635463fff648cff59009264082efd18861082871ec52b95f9dffd383786bca4bf045ef72df200c5fda9ebd332d144151cced3adac270fc2"} build_url:https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ffd174bfdf9ed49fe67636206ffa1a5ecd38653600239a2cb072412c2ae951a4107612774bf72e1bb49c8857e59cc4f0d54bbef5a00876b03b707f21d0a4b6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8589dd54a25eaba1ff5ba6b6ff70fabd2544df6585deb94613ebedb5ae901969fe1840f7b80fdd42a98be1670ed5a1b6fa3d5ed31fd5875bb30bb6ed5587cd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6176e1de87dfb83de635463fff648cff59009264082efd18861082871ec52b95f9dffd383786bca4bf045ef72df200c5fda9ebd332d144151cced3adac270fc2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:43:08.317392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:43:08.318046) ========= 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=923d835db2ba3686ebe126b700000192-1472667696.960465-2054329641 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:43:08.402872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:43:08.403494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:43:08.403964) ========= ========= Total master_lag: 0.18 =========