builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1469104369.24 results: success (0) buildid: 20160721023924 builduid: fa3dd57b361f4193ad89a24ebd3dc58c revision: f272791a6d75ec9d551f9c73493eaa39021e5827 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.238807) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.247793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.248085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.264460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.264892) ========= 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=db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 05:32:49-- 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% 67.1M=0s 2016-07-21 05:32:49 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.408980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.409379) ========= 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=db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014575 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:49.459349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:32:49.459701) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f272791a6d75ec9d551f9c73493eaa39021e5827 --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 f272791a6d75ec9d551f9c73493eaa39021e5827 --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=db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 05:32:49,847 truncating revision to first 12 chars 2016-07-21 05:32:49,847 Setting DEBUG logging. 2016-07-21 05:32:49,847 attempt 1/10 2016-07-21 05:32:49,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f272791a6d75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 05:32:50,854 unpacking tar archive at: fx-team-f272791a6d75/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:32:50.804269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:50.804668) ========= script_repo_revision: f272791a6d75ec9d551f9c73493eaa39021e5827 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:50.805056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:50.805317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:32:50.815167) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-21 05:32:50.815524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:51 INFO - MultiFileLogger online at 20160721 05:32:51 in /builds/slave/test 05:32:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:32:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:51 INFO - {'append_to_log': False, 05:32:51 INFO - 'base_work_dir': '/builds/slave/test', 05:32:51 INFO - 'blob_upload_branch': 'Fx-Team', 05:32:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:51 INFO - 'branch': 'Fx-Team', 05:32:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:51 INFO - 'config_files': ('talos/linux_config.py',), 05:32:51 INFO - 'default_actions': ('clobber', 05:32:51 INFO - 'read-buildbot-config', 05:32:51 INFO - 'download-and-extract', 05:32:51 INFO - 'populate-webroot', 05:32:51 INFO - 'create-virtualenv', 05:32:51 INFO - 'install', 05:32:51 INFO - 'run-tests'), 05:32:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:51 INFO - 'download_minidump_stackwalk': True, 05:32:51 INFO - 'download_symbols': 'ondemand', 05:32:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:51 INFO - 'installer_path': 'installer.exe', 05:32:51 INFO - 'log_level': 'info', 05:32:51 INFO - 'log_name': 'talos', 05:32:51 INFO - 'log_to_console': True, 05:32:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:51 INFO - 'opt_config_files': (), 05:32:51 INFO - 'pip_index': False, 05:32:51 INFO - 'sps_profile': False, 05:32:51 INFO - 'sps_profile_interval': 0, 05:32:51 INFO - 'suite': 'dromaeojs-e10s', 05:32:51 INFO - 'system_bits': '32', 05:32:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:51 INFO - 'title': 'talos-linux64-ix-031', 05:32:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:51 INFO - 'use_talos_json': True, 05:32:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:51 INFO - 'work_dir': 'build'} 05:32:51 INFO - [mozharness: 2016-07-21 12:32:51.300978Z] Running clobber step. 05:32:51 INFO - Running pre-action listener: _resource_record_pre_action 05:32:51 INFO - Running main action method: clobber 05:32:51 INFO - rmtree: /builds/slave/test/build 05:32:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:52 INFO - Running post-action listener: _resource_record_post_action 05:32:52 INFO - [mozharness: 2016-07-21 12:32:52.293442Z] Finished clobber step (success) 05:32:52 INFO - [mozharness: 2016-07-21 12:32:52.293541Z] Running read-buildbot-config step. 05:32:52 INFO - Running pre-action listener: _resource_record_pre_action 05:32:52 INFO - Running main action method: read_buildbot_config 05:32:52 INFO - Using buildbot properties: 05:32:52 INFO - { 05:32:52 INFO - "project": "", 05:32:52 INFO - "product": "firefox", 05:32:52 INFO - "script_repo_revision": "production", 05:32:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:32:52 INFO - "repository": "", 05:32:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:32:52 INFO - "buildid": "20160721023924", 05:32:52 INFO - "pgo_build": "True", 05:32:52 INFO - "basedir": "/builds/slave/test", 05:32:52 INFO - "buildnumber": 959, 05:32:52 INFO - "slavename": "talos-linux64-ix-031", 05:32:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:32:52 INFO - "platform": "ubuntu64_hw", 05:32:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:32:52 INFO - "branch": "fx-team", 05:32:52 INFO - "repo_path": "integration/fx-team", 05:32:52 INFO - "revision": "f272791a6d75ec9d551f9c73493eaa39021e5827", 05:32:52 INFO - "stage_platform": "linux64-pgo", 05:32:52 INFO - "builduid": "fa3dd57b361f4193ad89a24ebd3dc58c", 05:32:52 INFO - "slavebuilddir": "test" 05:32:52 INFO - } 05:32:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:32:52 INFO - Running post-action listener: _resource_record_post_action 05:32:52 INFO - [mozharness: 2016-07-21 12:32:52.295950Z] Finished read-buildbot-config step (success) 05:32:52 INFO - [mozharness: 2016-07-21 12:32:52.296039Z] Running download-and-extract step. 05:32:52 INFO - Running pre-action listener: _resource_record_pre_action 05:32:52 INFO - Running main action method: download_and_extract 05:32:52 INFO - mkdir: /builds/slave/test/build/tests 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:52 INFO - https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:32:52 INFO - Downloaded 1361 bytes. 05:32:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:32:52 INFO - Using the following test package requirements: 05:32:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:32:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:32:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'jsshell-linux-x86_64.zip'], 05:32:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:32:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:32:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:32:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:32:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:32:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:52 INFO - https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:32:53 INFO - Downloaded 24343178 bytes. 05:32:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:32:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:32:55 INFO - Return code: 0 05:32:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:55 INFO - https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:32:56 INFO - Downloaded 24343178 bytes. 05:32:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:32:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:32:57 INFO - Return code: 0 05:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:57 INFO - https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:32:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:33:00 INFO - Downloaded 14403317 bytes. 05:33:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:33:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:33:00 INFO - Return code: 0 05:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:00 INFO - https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:33:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:33:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:33:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:33:01 INFO - Downloaded 60887395 bytes. 05:33:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:33:01 INFO - mkdir: /builds/slave/test/properties 05:33:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:01 INFO - Contents: 05:33:01 INFO - build_url:https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:33:02 INFO - Running post-action listener: _resource_record_post_action 05:33:02 INFO - Running post-action listener: set_extra_try_arguments 05:33:02 INFO - [mozharness: 2016-07-21 12:33:02.953524Z] Finished download-and-extract step (success) 05:33:02 INFO - [mozharness: 2016-07-21 12:33:02.953755Z] Running populate-webroot step. 05:33:02 INFO - Running pre-action listener: _resource_record_pre_action 05:33:02 INFO - Running main action method: populate_webroot 05:33:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:02 INFO - '--tppagecycles', 05:33:02 INFO - '7'], 05:33:02 INFO - 'tests': ['tsvgm']}}, 05:33:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['damp', 'tps']}, 05:33:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'tests': ['damp', 'tps']}, 05:33:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['dromaeo_dom']}, 05:33:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['basic_compositor_video']}, 05:33:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:33:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['a11yr', 05:33:02 INFO - 'ts_paint', 05:33:02 INFO - 'tpaint', 05:33:02 INFO - 'sessionrestore', 05:33:02 INFO - 'sessionrestore_no_auto_restore', 05:33:02 INFO - 'tabpaint']}, 05:33:02 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:02 INFO - 'ts_paint', 05:33:02 INFO - 'tpaint', 05:33:02 INFO - 'sessionrestore', 05:33:02 INFO - 'sessionrestore_no_auto_restore', 05:33:02 INFO - 'tabpaint']}, 05:33:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:33:02 INFO - 'ts_paint', 05:33:02 INFO - 'tpaint', 05:33:02 INFO - 'sessionrestore', 05:33:02 INFO - 'sessionrestore_no_auto_restore', 05:33:02 INFO - 'tabpaint']}, 05:33:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:33:02 INFO - 'ts_paint', 05:33:02 INFO - 'tpaint', 05:33:02 INFO - 'sessionrestore', 05:33:02 INFO - 'sessionrestore_no_auto_restore', 05:33:02 INFO - 'tabpaint']}, 05:33:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['a11yr', 05:33:02 INFO - 'ts_paint', 05:33:02 INFO - 'tpaint', 05:33:02 INFO - 'sessionrestore', 05:33:02 INFO - 'sessionrestore_no_auto_restore', 05:33:02 INFO - 'tabpaint']}, 05:33:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['a11yr', 05:33:02 INFO - 'ts_paint', 05:33:02 INFO - 'tpaint', 05:33:02 INFO - 'sessionrestore', 05:33:02 INFO - 'sessionrestore_no_auto_restore', 05:33:02 INFO - 'tabpaint']}, 05:33:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['tsvgx', 05:33:02 INFO - 'tsvgr_opacity', 05:33:02 INFO - 'tart', 05:33:02 INFO - 'tscrollx', 05:33:02 INFO - 'cart']}, 05:33:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:02 INFO - 'tsvgr_opacity', 05:33:02 INFO - 'tart', 05:33:02 INFO - 'tscrollx', 05:33:02 INFO - 'cart']}, 05:33:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'talos_options': ['--disable-e10s'], 05:33:02 INFO - 'tests': ['tp5o']}, 05:33:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'tests': ['tp5o']}, 05:33:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'talos_options': ['--disable-e10s', 05:33:02 INFO - '--xperf_path', 05:33:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:02 INFO - 'tests': ['tp5n']}, 05:33:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:02 INFO - 'talos_options': ['--xperf_path', 05:33:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:02 INFO - 'tests': ['tp5n']}}, 05:33:02 INFO - 'talos.zip': {'path': '', 05:33:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:02 INFO - Running post-action listener: _resource_record_post_action 05:33:02 INFO - [mozharness: 2016-07-21 12:33:02.974157Z] Finished populate-webroot step (success) 05:33:02 INFO - [mozharness: 2016-07-21 12:33:02.974245Z] Running create-virtualenv step. 05:33:02 INFO - Running pre-action listener: _resource_record_pre_action 05:33:02 INFO - Running main action method: create_virtualenv 05:33:02 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:33:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:03 INFO - Using real prefix '/usr' 05:33:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:05 INFO - Installing pip.................done. 05:33:05 INFO - Return code: 0 05:33:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:33:05 INFO - Using env: {'DISPLAY': ':0', 05:33:05 INFO - 'HOME': '/home/cltbld', 05:33:05 INFO - 'LANG': 'en_US.UTF-8', 05:33:05 INFO - 'LANGUAGE': 'en_US:en', 05:33:05 INFO - 'LOGNAME': 'cltbld', 05:33:05 INFO - 'MAIL': '/var/mail/cltbld', 05:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:05 INFO - 'MOZ_NO_REMOTE': '1', 05:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:05 INFO - 'NO_EM_RESTART': '1', 05:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:05 INFO - 'PWD': '/builds/slave/test', 05:33:05 INFO - 'SHELL': '/bin/bash', 05:33:05 INFO - 'SHLVL': '1', 05:33:05 INFO - 'TERM': 'linux', 05:33:05 INFO - 'TMOUT': '86400', 05:33:05 INFO - 'USER': 'cltbld', 05:33:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:05 INFO - '_': '/tools/buildbot/bin/python'} 05:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:33:05 INFO - Cleaning up... 05:33:05 INFO - Return code: 0 05:33:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:33:05 INFO - Using env: {'DISPLAY': ':0', 05:33:05 INFO - 'HOME': '/home/cltbld', 05:33:05 INFO - 'LANG': 'en_US.UTF-8', 05:33:05 INFO - 'LANGUAGE': 'en_US:en', 05:33:05 INFO - 'LOGNAME': 'cltbld', 05:33:05 INFO - 'MAIL': '/var/mail/cltbld', 05:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:05 INFO - 'MOZ_NO_REMOTE': '1', 05:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:05 INFO - 'NO_EM_RESTART': '1', 05:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:05 INFO - 'PWD': '/builds/slave/test', 05:33:05 INFO - 'SHELL': '/bin/bash', 05:33:05 INFO - 'SHLVL': '1', 05:33:05 INFO - 'TERM': 'linux', 05:33:05 INFO - 'TMOUT': '86400', 05:33:05 INFO - 'USER': 'cltbld', 05:33:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:05 INFO - '_': '/tools/buildbot/bin/python'} 05:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:05 INFO - Downloading/unpacking psutil>=3.1.1 05:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:07 INFO - Installing collected packages: psutil 05:33:07 INFO - Running setup.py install for psutil 05:33:08 INFO - building 'psutil._psutil_linux' extension 05:33:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:33:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:33:08 INFO - building 'psutil._psutil_posix' extension 05:33:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:33:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:33:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:08 INFO - Successfully installed psutil 05:33:08 INFO - Cleaning up... 05:33:08 INFO - Return code: 0 05:33:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:08 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:33:08 INFO - Using env: {'DISPLAY': ':0', 05:33:08 INFO - 'HOME': '/home/cltbld', 05:33:08 INFO - 'LANG': 'en_US.UTF-8', 05:33:08 INFO - 'LANGUAGE': 'en_US:en', 05:33:08 INFO - 'LOGNAME': 'cltbld', 05:33:08 INFO - 'MAIL': '/var/mail/cltbld', 05:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:08 INFO - 'MOZ_NO_REMOTE': '1', 05:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:08 INFO - 'NO_EM_RESTART': '1', 05:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:08 INFO - 'PWD': '/builds/slave/test', 05:33:08 INFO - 'SHELL': '/bin/bash', 05:33:08 INFO - 'SHLVL': '1', 05:33:08 INFO - 'TERM': 'linux', 05:33:08 INFO - 'TMOUT': '86400', 05:33:08 INFO - 'USER': 'cltbld', 05:33:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:08 INFO - '_': '/tools/buildbot/bin/python'} 05:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:10 INFO - Installing collected packages: mozsystemmonitor 05:33:10 INFO - Running setup.py install for mozsystemmonitor 05:33:10 INFO - Successfully installed mozsystemmonitor 05:33:10 INFO - Cleaning up... 05:33:10 INFO - Return code: 0 05:33:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:10 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:33:10 INFO - Using env: {'DISPLAY': ':0', 05:33:10 INFO - 'HOME': '/home/cltbld', 05:33:10 INFO - 'LANG': 'en_US.UTF-8', 05:33:10 INFO - 'LANGUAGE': 'en_US:en', 05:33:10 INFO - 'LOGNAME': 'cltbld', 05:33:10 INFO - 'MAIL': '/var/mail/cltbld', 05:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:10 INFO - 'MOZ_NO_REMOTE': '1', 05:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:10 INFO - 'NO_EM_RESTART': '1', 05:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:10 INFO - 'PWD': '/builds/slave/test', 05:33:10 INFO - 'SHELL': '/bin/bash', 05:33:10 INFO - 'SHLVL': '1', 05:33:10 INFO - 'TERM': 'linux', 05:33:10 INFO - 'TMOUT': '86400', 05:33:10 INFO - 'USER': 'cltbld', 05:33:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:10 INFO - '_': '/tools/buildbot/bin/python'} 05:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:13 INFO - warning: no files found matching '*.txt' 05:33:13 INFO - no previously-included directories found matching 'build' 05:33:13 INFO - no previously-included directories found matching 'dist' 05:33:13 INFO - no previously-included directories found matching '.git*' 05:33:13 INFO - Installing collected packages: jsonschema, functools32 05:33:13 INFO - Running setup.py install for functools32 05:33:13 INFO - warning: no files found matching '*.txt' 05:33:13 INFO - no previously-included directories found matching 'build' 05:33:13 INFO - no previously-included directories found matching 'dist' 05:33:13 INFO - no previously-included directories found matching '.git*' 05:33:13 INFO - Successfully installed jsonschema functools32 05:33:13 INFO - Cleaning up... 05:33:13 INFO - Return code: 0 05:33:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:13 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:33:13 INFO - Using env: {'DISPLAY': ':0', 05:33:13 INFO - 'HOME': '/home/cltbld', 05:33:13 INFO - 'LANG': 'en_US.UTF-8', 05:33:13 INFO - 'LANGUAGE': 'en_US:en', 05:33:13 INFO - 'LOGNAME': 'cltbld', 05:33:13 INFO - 'MAIL': '/var/mail/cltbld', 05:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:13 INFO - 'MOZ_NO_REMOTE': '1', 05:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:13 INFO - 'NO_EM_RESTART': '1', 05:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:13 INFO - 'PWD': '/builds/slave/test', 05:33:13 INFO - 'SHELL': '/bin/bash', 05:33:13 INFO - 'SHLVL': '1', 05:33:13 INFO - 'TERM': 'linux', 05:33:13 INFO - 'TMOUT': '86400', 05:33:13 INFO - 'USER': 'cltbld', 05:33:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:13 INFO - '_': '/tools/buildbot/bin/python'} 05:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:16 INFO - Downloading docopt-0.6.1.tar.gz 05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:16 INFO - Running setup.py install for blobuploader 05:33:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:16 INFO - Running setup.py install for requests 05:33:16 INFO - Running setup.py install for docopt 05:33:16 INFO - Successfully installed blobuploader requests docopt 05:33:16 INFO - Cleaning up... 05:33:16 INFO - Return code: 0 05:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:16 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:16 INFO - Using env: {'DISPLAY': ':0', 05:33:16 INFO - 'HOME': '/home/cltbld', 05:33:16 INFO - 'LANG': 'en_US.UTF-8', 05:33:16 INFO - 'LANGUAGE': 'en_US:en', 05:33:16 INFO - 'LOGNAME': 'cltbld', 05:33:16 INFO - 'MAIL': '/var/mail/cltbld', 05:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:16 INFO - 'MOZ_NO_REMOTE': '1', 05:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:16 INFO - 'NO_EM_RESTART': '1', 05:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:16 INFO - 'PWD': '/builds/slave/test', 05:33:16 INFO - 'SHELL': '/bin/bash', 05:33:16 INFO - 'SHLVL': '1', 05:33:16 INFO - 'TERM': 'linux', 05:33:16 INFO - 'TMOUT': '86400', 05:33:16 INFO - 'USER': 'cltbld', 05:33:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:16 INFO - '_': '/tools/buildbot/bin/python'} 05:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:17 INFO - Running setup.py (path:/tmp/pip-pjq20f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:17 INFO - Running setup.py (path:/tmp/pip-WkqrrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:17 INFO - Running setup.py (path:/tmp/pip-baU8SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:17 INFO - Running setup.py (path:/tmp/pip-XDl0xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:17 INFO - Running setup.py (path:/tmp/pip-JwXDAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:17 INFO - Running setup.py (path:/tmp/pip-_v8J3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:17 INFO - Running setup.py (path:/tmp/pip-NZ3rsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:17 INFO - Running setup.py (path:/tmp/pip-tngftu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:17 INFO - Running setup.py (path:/tmp/pip-_j7QUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:17 INFO - Running setup.py (path:/tmp/pip-JNbt82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:17 INFO - Running setup.py (path:/tmp/pip-Zup8IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:17 INFO - Running setup.py (path:/tmp/pip-h9x9J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:18 INFO - Running setup.py (path:/tmp/pip-AxWf65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:18 INFO - Running setup.py (path:/tmp/pip-hSpbjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:18 INFO - Running setup.py (path:/tmp/pip-iZinAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:18 INFO - Running setup.py (path:/tmp/pip-uqCshv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:18 INFO - Running setup.py (path:/tmp/pip-PwuTLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:18 INFO - Running setup.py install for manifestparser 05:33:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:18 INFO - Running setup.py install for mozcrash 05:33:18 INFO - Running setup.py install for mozdebug 05:33:18 INFO - Running setup.py install for mozdevice 05:33:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:18 INFO - Running setup.py install for mozfile 05:33:18 INFO - Running setup.py install for mozhttpd 05:33:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozinfo 05:33:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozInstall 05:33:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozleak 05:33:19 INFO - Running setup.py install for mozlog 05:33:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for moznetwork 05:33:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozprocess 05:33:19 INFO - Running setup.py install for mozprofile 05:33:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozrunner 05:33:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozscreenshot 05:33:19 INFO - Running setup.py install for moztest 05:33:20 INFO - Running setup.py install for mozversion 05:33:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:20 INFO - Cleaning up... 05:33:20 INFO - Return code: 0 05:33:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:20 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:20 INFO - Using env: {'DISPLAY': ':0', 05:33:20 INFO - 'HOME': '/home/cltbld', 05:33:20 INFO - 'LANG': 'en_US.UTF-8', 05:33:20 INFO - 'LANGUAGE': 'en_US:en', 05:33:20 INFO - 'LOGNAME': 'cltbld', 05:33:20 INFO - 'MAIL': '/var/mail/cltbld', 05:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:20 INFO - 'MOZ_NO_REMOTE': '1', 05:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:20 INFO - 'NO_EM_RESTART': '1', 05:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:20 INFO - 'PWD': '/builds/slave/test', 05:33:20 INFO - 'SHELL': '/bin/bash', 05:33:20 INFO - 'SHLVL': '1', 05:33:20 INFO - 'TERM': 'linux', 05:33:20 INFO - 'TMOUT': '86400', 05:33:20 INFO - 'USER': 'cltbld', 05:33:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:20 INFO - '_': '/tools/buildbot/bin/python'} 05:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:20 INFO - Running setup.py (path:/tmp/pip-23IlHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:20 INFO - Running setup.py (path:/tmp/pip-NENQMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:20 INFO - Running setup.py (path:/tmp/pip-a2OWgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:20 INFO - Running setup.py (path:/tmp/pip-sf98TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:20 INFO - Running setup.py (path:/tmp/pip-kSSMtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:20 INFO - Running setup.py (path:/tmp/pip-AS1WmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:20 INFO - Running setup.py (path:/tmp/pip-YncpKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:20 INFO - Running setup.py (path:/tmp/pip-Q40TnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:21 INFO - Running setup.py (path:/tmp/pip-zDdOrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:21 INFO - Running setup.py (path:/tmp/pip-I_9z23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:21 INFO - Running setup.py (path:/tmp/pip-dvO6Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:21 INFO - Running setup.py (path:/tmp/pip-HAL2lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:21 INFO - Running setup.py (path:/tmp/pip-zm2I7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:21 INFO - Running setup.py (path:/tmp/pip-Ku26zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:21 INFO - Running setup.py (path:/tmp/pip-eOE_uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:21 INFO - Running setup.py (path:/tmp/pip-e9vZK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:21 INFO - Running setup.py (path:/tmp/pip-wLUq_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:23 INFO - Downloading blessings-1.6.tar.gz 05:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:23 INFO - Installing collected packages: blessings 05:33:23 INFO - Running setup.py install for blessings 05:33:23 INFO - Successfully installed blessings 05:33:23 INFO - Cleaning up... 05:33:23 INFO - Return code: 0 05:33:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:24 INFO - Reading from file tmpfile_stdout 05:33:24 INFO - Current package versions: 05:33:24 INFO - argparse == 1.2.1 05:33:24 INFO - blessings == 1.6 05:33:24 INFO - blobuploader == 1.2.4 05:33:24 INFO - docopt == 0.6.1 05:33:24 INFO - functools32 == 3.2.3-2 05:33:24 INFO - jsonschema == 2.5.1 05:33:24 INFO - manifestparser == 1.1 05:33:24 INFO - mozInstall == 1.12 05:33:24 INFO - mozcrash == 0.17 05:33:24 INFO - mozdebug == 0.1 05:33:24 INFO - mozdevice == 0.48 05:33:24 INFO - mozfile == 1.2 05:33:24 INFO - mozhttpd == 0.7 05:33:24 INFO - mozinfo == 0.9 05:33:24 INFO - mozleak == 0.1 05:33:24 INFO - mozlog == 3.3 05:33:24 INFO - moznetwork == 0.27 05:33:24 INFO - mozprocess == 0.23 05:33:24 INFO - mozprofile == 0.28 05:33:24 INFO - mozrunner == 6.12 05:33:24 INFO - mozscreenshot == 0.1 05:33:24 INFO - mozsystemmonitor == 0.3 05:33:24 INFO - moztest == 0.7 05:33:24 INFO - mozversion == 1.4 05:33:24 INFO - psutil == 3.1.1 05:33:24 INFO - requests == 1.2.3 05:33:24 INFO - wsgiref == 0.1.2 05:33:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 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 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:24 INFO - Using env: {'DISPLAY': ':0', 05:33:24 INFO - 'HOME': '/home/cltbld', 05:33:24 INFO - 'LANG': 'en_US.UTF-8', 05:33:24 INFO - 'LANGUAGE': 'en_US:en', 05:33:24 INFO - 'LOGNAME': 'cltbld', 05:33:24 INFO - 'MAIL': '/var/mail/cltbld', 05:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:24 INFO - 'MOZ_NO_REMOTE': '1', 05:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:24 INFO - 'NO_EM_RESTART': '1', 05:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:24 INFO - 'PWD': '/builds/slave/test', 05:33:24 INFO - 'SHELL': '/bin/bash', 05:33:24 INFO - 'SHLVL': '1', 05:33:24 INFO - 'TERM': 'linux', 05:33:24 INFO - 'TMOUT': '86400', 05:33:24 INFO - 'USER': 'cltbld', 05:33:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:24 INFO - '_': '/tools/buildbot/bin/python'} 05:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:24 INFO - Cleaning up... 05:33:24 INFO - Return code: 0 05:33:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, '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': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:33:24 INFO - Using env: {'DISPLAY': ':0', 05:33:24 INFO - 'HOME': '/home/cltbld', 05:33:24 INFO - 'LANG': 'en_US.UTF-8', 05:33:24 INFO - 'LANGUAGE': 'en_US:en', 05:33:24 INFO - 'LOGNAME': 'cltbld', 05:33:24 INFO - 'MAIL': '/var/mail/cltbld', 05:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:24 INFO - 'MOZ_NO_REMOTE': '1', 05:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:24 INFO - 'NO_EM_RESTART': '1', 05:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:24 INFO - 'PWD': '/builds/slave/test', 05:33:24 INFO - 'SHELL': '/bin/bash', 05:33:24 INFO - 'SHLVL': '1', 05:33:24 INFO - 'TERM': 'linux', 05:33:24 INFO - 'TMOUT': '86400', 05:33:24 INFO - 'USER': 'cltbld', 05:33:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:24 INFO - '_': '/tools/buildbot/bin/python'} 05:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:24 INFO - Cleaning up... 05:33:24 INFO - Return code: 0 05:33:24 INFO - Running post-action listener: _resource_record_post_action 05:33:24 INFO - Running post-action listener: _start_resource_monitoring 05:33:24 INFO - Starting resource monitoring. 05:33:24 INFO - [mozharness: 2016-07-21 12:33:24.506425Z] Finished create-virtualenv step (success) 05:33:24 INFO - [mozharness: 2016-07-21 12:33:24.506904Z] Running install step. 05:33:24 INFO - Running pre-action listener: _resource_record_pre_action 05:33:24 INFO - Running main action method: install 05:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:24 INFO - Reading from file tmpfile_stdout 05:33:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:24 INFO - Reading from file tmpfile_stdout 05:33:24 INFO - Output received: 05:33:24 INFO - Usage: mozinstall [options] installer 05:33:24 INFO - Options: 05:33:24 INFO - -h, --help show this help message and exit 05:33:24 INFO - -d DEST, --destination=DEST 05:33:24 INFO - Directory to install application into. [default: 05:33:24 INFO - "/builds/slave/test"] 05:33:24 INFO - --app=APP Application being installed. [default: firefox] 05:33:24 INFO - mkdir: /builds/slave/test/build/application 05:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:33:42 INFO - Reading from file tmpfile_stdout 05:33:42 INFO - Output received: 05:33:42 INFO - /builds/slave/test/build/application/firefox/firefox 05:33:42 INFO - Running post-action listener: _resource_record_post_action 05:33:42 INFO - [mozharness: 2016-07-21 12:33:42.097750Z] Finished install step (success) 05:33:42 INFO - [mozharness: 2016-07-21 12:33:42.098026Z] Running run-tests step. 05:33:42 INFO - Running pre-action listener: _resource_record_pre_action 05:33:42 INFO - Running main action method: run_tests 05:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:42 INFO - Python 2.7.3 05:33:42 INFO - Return code: 0 05:33:42 INFO - grabbing minidump binary from tooltool 05:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:42 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 0x21b53b0>, '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 0x21b62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:33:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:33:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:33:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:42 INFO - Return code: 0 05:33:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:33:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:33:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:33:42 INFO - Using env: {'DISPLAY': ':0', 05:33:42 INFO - 'HOME': '/home/cltbld', 05:33:42 INFO - 'LANG': 'en_US.UTF-8', 05:33:42 INFO - 'LANGUAGE': 'en_US:en', 05:33:42 INFO - 'LOGNAME': 'cltbld', 05:33:42 INFO - 'MAIL': '/var/mail/cltbld', 05:33:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:42 INFO - 'MOZ_NO_REMOTE': '1', 05:33:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:42 INFO - 'NO_EM_RESTART': '1', 05:33:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:42 INFO - 'PWD': '/builds/slave/test', 05:33:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:42 INFO - 'SHELL': '/bin/bash', 05:33:42 INFO - 'SHLVL': '1', 05:33:42 INFO - 'TERM': 'linux', 05:33:42 INFO - 'TMOUT': '86400', 05:33:42 INFO - 'USER': 'cltbld', 05:33:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316', 05:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:42 INFO - '_': '/tools/buildbot/bin/python'} 05:33:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:33:42 INFO - mozversion application_buildid: 20160721023924 05:33:42 INFO - mozversion application_changeset: f272791a6d75ec9d551f9c73493eaa39021e5827 05:33:42 INFO - mozversion application_display_name: Nightly 05:33:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:42 INFO - mozversion application_name: Firefox 05:33:42 INFO - mozversion application_remotingname: firefox 05:33:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:33:42 INFO - mozversion application_vendor: Mozilla 05:33:42 INFO - mozversion application_version: 50.0a1 05:33:42 INFO - mozversion platform_buildid: 20160721023924 05:33:42 INFO - mozversion platform_changeset: f272791a6d75ec9d551f9c73493eaa39021e5827 05:33:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:33:42 INFO - mozversion platform_version: 50.0a1 05:33:42 INFO - using testdate: 1469104422 05:33:42 INFO - actual date: 1469104422 05:33:42 INFO - starting webserver on 'localhost:48809' 05:33:42 INFO - SUITE-START | Running 2 tests 05:33:42 INFO - TEST-START | dromaeo_css 05:33:42 INFO - operating with platform_type : linux_ 05:33:42 INFO - Initialising browser for dromaeo_css test... 05:33:42 INFO - TEST-INFO | started process 25600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi8pYIN/profile http://localhost:48809/getInfo.html) 05:33:46 INFO - PROCESS | 25600 | __metrics Screen width/height:1600/1200 05:33:46 INFO - PROCESS | 25600 | colorDepth:24 05:33:46 INFO - PROCESS | 25600 | Browser inner width/height: 1024/697 05:33:46 INFO - PROCESS | 25600 | __metrics 05:33:47 ERROR - PROCESS | 25600 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:33:48 INFO - TEST-INFO | 25600: exit 0 05:33:48 INFO - Browser initialized. 05:33:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:48 INFO - TEST-INFO | started process 25719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi8pYIN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:00 INFO - PROCESS | 25719 | RSS: Main: 166887424 05:34:00 INFO - PROCESS | 25719 | 05:34:50 INFO - PROCESS | 25719 | 1469104490163 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:58 INFO - PROCESS | 25719 | Cycle 1(1): loaded http://localhost:48809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48809/tests/dromaeo/cssquery-ext.html) 05:36:59 INFO - PROCESS | 25719 | RSS: Main: 172191744 05:36:59 INFO - PROCESS | 25719 | 05:40:01 INFO - PROCESS | 25719 | Cycle 1(1): loaded http://localhost:48809/tests/dromaeo/cssquery-ext.html (next: http://localhost:48809/tests/dromaeo/cssquery-jquery.html) 05:40:02 INFO - PROCESS | 25719 | RSS: Main: 169422848 05:40:02 INFO - PROCESS | 25719 | 05:43:03 INFO - PROCESS | 25719 | Cycle 1(1): loaded http://localhost:48809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48809/tests/dromaeo/cssquery-mootools.html) 05:43:04 INFO - PROCESS | 25719 | RSS: Main: 173158400 05:43:04 INFO - PROCESS | 25719 | 05:46:06 INFO - PROCESS | 25719 | Cycle 1(1): loaded http://localhost:48809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48809/tests/dromaeo/cssquery-prototype.html) 05:46:07 INFO - PROCESS | 25719 | RSS: Main: 167505920 05:46:07 INFO - PROCESS | 25719 | 05:49:09 INFO - PROCESS | 25719 | Cycle 1(1): loaded http://localhost:48809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48809/tests/dromaeo/cssquery-yui.html) 05:49:10 INFO - PROCESS | 25719 | RSS: Main: 169918464 05:49:10 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | Cycle 1(1): loaded http://localhost:48809/tests/dromaeo/cssquery-yui.html (next: http://localhost:48809/tests/dromaeo/cssquery-dojo.html) 05:52:13 INFO - PROCESS | 25719 | RSS: Main: 170672128 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | __start_tp_report 05:52:13 INFO - PROCESS | 25719 | _x_x_mozilla_page_load 05:52:13 INFO - PROCESS | 25719 | _x_x_mozilla_page_load_details 05:52:13 INFO - PROCESS | 25719 | |i|pagename|runs| 05:52:13 INFO - PROCESS | 25719 | |0;dojo.html;3058.8929387471435;3071.8924837630675;3093.242155671861;3100.1474594486513;3101.7673674474404;5347.786088556458;5350.839474815757;5366;5444.1561557958485;5489.560835133189;5368;5414.35027796664;5472;5494.423085576017;5504.4770746778995;4954.083494553501;4974.850754477362;5010.323606313155;5088.516590923857;5089.058524173021;4987.925181122286;5072.822451214208;5081.7459127043685;5108.6168537359845;5119.104156772569;4900.705957642553;4944.085344211332;4968.22992436173;5022.598192144638;5023.246513023039;4950.9504904950845;4989.151844186497;5018.121828679967;5047.798088076473;5057.747112644353;4954.3063971044085;4957.380327459067;4961.9751901240625;4976.104301225778;5010.749462526859;5230.843074707765;5417.945820541783;5443.265159203496;5465.262189604432;5498.752556134984;5826.9708651456895;5863.5309175265875;5876.059830427154;5894.351621321651;5902.203202567642;5878.265216847894;5889.02831032879;5899.380565040652;5910.172575839343;5933.3473317934995;5377.892442151135;5405.675659460445;5502.312210973629;5525.171224316345;5543.196236545678;5895.646261224255;5950.958582248176;5958.523318134538;5992.970035149797;5996.910046349309;5694.231278777394;5696.943030569641;5708.429157084342;5720.3421606515785;5726.198332233491;5609.349913740618;5778.653280803165;5818.981678206382;5820.912686309709;5820.941790582125;5618.073017952074;5748.540116790647;5793.102069179284;5883.970580147072;5887.735051922674;5862.912056319158;5867.413258674183;5869.706514674249;5869.765209391662;5929.584929055011;4456.799444025027;4457.710248833815;4466.821327146943;4467.195904737114;4511;3873.825677844504;3977.463042489285;3997.2205419942834;4009.3184158693093;4057.229126465962;5678.4037676044245;5701.942980570224;5705.22979397776;5714.428557144252;5719.056355701346;5938.376470470625;5962.07587823888;5986.700664966735;6002.219711437572;6002.339742628307;5415.620906536505;5443.755031023614;5486.6982315973;5489.835304940858;5556.72216389187;4846.539578740014;4858.295547145714;4876.926846097312;4876.975615121902;4878.756062196876;5928.7332070056955;5929.584929054925;5930.080837470113;5939.732712027969;5945.702714864239;5724.227229324071;5844.357120716632;5869.6771677558145;5892.35184129754;5953.404659534012;5943.049112142036;5972.432618901197;5999.310079340931;6035.9437098506705;6053.75784968614;5706.600537962303;5743.62666426681;5758.8848223034465;5764.048931926185;5766.192733017297;5643.068893632669;5844.47399734026;5864.091065884794;5870.911936320873;5932.0508718604815;5747.51146152565;5758.280214973129;5765.221695071112;5776.162456443708;5788.623739456922;5713.428657134419;5721.370649228665;5731.942680573141;5735.139729040678;5737.426257374229;5460.5904557159165;5583.776648933997;5618.2415373924;5635.295588051494;5647.1529270609735;5637.069883469346;5664.546836253172;5681.744321505459;5694.943050569441;5700.401457847032;5561.054620714569;5641.9435805641415;5649;5649.68926709035;5676.20533125371 05:52:13 INFO - PROCESS | 25719 | |1;ext.html;553.3347869273447;585.8769658371742;602.7853874442998;612.5405945540845;640.5388120553206;39290.803545982264;43495.56504434955;44071.55928440714;44190.77904610476;44366.33450498245;44468;44871;44910.77544612272;45000.77499612497;45068.323975140396;8916.821663566725;9062.592183351731;9108.772280693003;9115.27077833775;9117.863232051524;9023.278137748965;9113.772155696095;9115.49864757438;9117.45295282282;9131.817363652723;9069.637214511411;9081.18269355758;9090.13643703847;9137.771555711128;9164.633414663438;9088.681896133636;9095.681651142178;9115.680951166743;9126.498042607654;9138.451692898414;9059;9117.361784675075;9121;9147.908520914772;9170.17468427838;43882.341764873556;44081.55918440839;44182;44319.77840110811;44346.55653443457;3493.7903725776537;3637.5271214741915;3673.540807399075;3714.7213958952916;3792.4880141180865;30903.690963090306;31297;31713.365732685448;31719.84140079308;32504.18739531507;4432.578905004019;4476.328550717386;4489.887752806173;4530.614897733697;4663.533646635343;250627;251040;252177;252342;252591;53700.462995370326;54019.45980540223;54129.752214867236;54348.72825635847;54349.1847622286;64927.350726493074;65483.34516654868;65814;65962.67018664876;66088.71290296764;16116.919415402848;17395.47813565595;17749.11254437273;17752;17937.910310448366;13132.212067275994;13171.802422963472;13174.670633234246;13279.867201328056;13327.333633318296;20231.898840505703;20353.59292814165;20499.795002050087;20584.176632934814;20753.688694669592;7154.821129471701;7408.591887826735;7453.440991925628;7557.2820582044615;7576.772696818994;951.752544338477;1052.984205236922;1126.6225814352283;1127.7518945831903;1151.0043812102472;33871;34214.657853421144;34274.82862585671;34661.65338346584;34701;1043.3426941027255;1096.9122470202365;1103.3876198709793;1123.8763735989035;1163.4531770068054;16218.67562648764;17279.7408038877;17289.654206916042;17306.826931730775;17458.65082698339;656476;667722;671000;679649;681207;63354.36645633577;63755;63905;64150.22647961706;64177;1342.9059965802496;1365.4196966289287;1371.9245441500814;1374.202962281874;1397.699494608664;31211.219719507193;32101.35797284088;32858;32947.79212736835;33089.33821323608;53449.73275133599;53669.73165134149;53687.73156134194;53778.462215377345;53815;494548;494684;495796;497290;499823;29414.558781617863;29577.85211073931;29892;29995.850020749756;30372.24069398283;50286;51260.48739512557;51807;52013;52331.73834130805;43938.56061439345;45445;45711.35182018964;45777.313340300585;46453.767731161126;44388.112237754416;45072;45195;45834.54165458303;46184.53815461937;43395;43506.78246608747;44076.77961610172;44289.557104429834;44705.55294447144;36704.63295367012;38360.616393835706;39427;39843.80078099591;39942.80028599955;28792;29297.121086367442;29739.851300743358;29803.701962980093;29959.40487141557 05:52:13 INFO - PROCESS | 25719 | |2;jquery.html;368.11284803623255;386.70803543324774;391.8785176595256;394.7710328009755;403.2398928020682;17652.20565074573;20009.799902000974;20032.4991875203;20273.59452810943;20299.289524866632;18813.153408096634;19166.61666766664;19189.136488858;19392.806071939278;19633;5616.213730077792;5730.541556675456;5738.483536481705;5846.619969701977;5911.970440147793;5746.913796293038;5748.367679555246;5762.250907382035;5772.942270577303;5782.855428614276;5289.68261904285;5506.174073888908;5540.889182216353;5688;5728.68492232927;5707.601637598794;5744.454276843714;5763.991301522259;5984.3417224105315;6354.205724284465;5661.66030038199;5750.597458177929;5784.2769653793275;5785.710714464302;5791.913121303184;13985.090969086978;16272.83727162725;20452.693209601868;21057.157713691435;21413.92930353492;2351.8588884666974;2534.1003943600126;2580.135654555726;2770.265879541923;2926.25380527964;10113.436651222217;10136.746581335525;10175;10352.430616316175;14127.799137073362;1775.5916139288036;1833.5049536625036;1858.7304840798145;1876.7372567840514;1901.7242499837446;84136.57931710363;84353.57823210907;86795;86809.56595216984;87599.56200218959;9993;10654.840177397346;10793.946030269799;10894.237403381845;10981.3960232188;15192.848071519364;15247.542573722805;15262.31319590621;15332;15357.232138393036;7568.318851303409;7617.390608751398;7965.681372745025;8377.162283771575;8446.197611226924;7488.213737557587;7599.848003039909;7754.534727916343;7843.215678432111;8072.717454889051;4440.2007638625355;4605.723656580616;4618.884527886763;4739.597134243559;4822.927656085161;1870.0910110958732;1883.2749391484103;1912.913918873654;1974.8518861085477;1997.131247907165;837.380338549469;848.3510114762212;914.7850255190025;925.5696101312788;1014.1633152648947;18498.81501184971;19592.804071959097;19658;19767.308144214883;19865.702014469796;955.245356168619;962.6101428921298;974.512743628186;988.5304480371766;1025.9025392587691;10539.367637941748;11073.50169242386;11093.889061109447;11161.107111431065;11191.720206994727;524299;524304;532297;543692;544421;92511;96036.51981740046;96327.51836240773;96788.51605741926;97758;980.3235767320526;1027.5222021760067;1033.6743925663393;1048.570086264628;1048.7902419516126;16410.179491025163;16847.578810529834;17492.47522574325;17761;18154.546136346697;33123;38982;41895;44061.559384407024;44722;59184.70407647934;60288.69855650693;60783.39216607954;61366.69316653388;61487.38512614817;7071.504994650325;7462.552246865205;7487.588182650006;8061.395395345256;8404.327653787805;9408.965013848334;12921.353932303535;13557.322133893069;13959.651008724863;14223.21772302492;11807.465029546447;11927.284362938251;11984.221025633306;12037.638870833889;12200.328981905725;11295.966725989401;11390.772184556428;11893.702657433634;11964.700882478008;12373.814392784296;7121.750738724119;12036.398180091135;12216.38918054076;12492;12762.680932976378;7395.445341599294;7525.473216874985;7623.390128789794;7777.1833957433655;7841.372690184886;10689.572417103229;11457.083433325148;11664.300141991507;11764.941175294069;11976.58081967127 05:52:13 INFO - PROCESS | 25719 | |3;mootools.html;1506.5480355893233;1516.772484127381;1683.8484536391722;1771.8139595342498;1815.9182836772343;7887.60561971902;8248.051474080468;8494.660213591456;9082.409643373176;9090.227330676893;8579.78550536237;8632.654693812256;8650.048494665598;8658.87011694825;8663.783405414868;2311.6763653088583;2352.3413444235644;2352.4118970257437;2353.1293421434093;2353.6587194856734;2294.139697613395;2296.115995341797;2365.9171928982487;2372.608519594265;2377.465070359164;2280.1221529711097;2285.931422057333;2308.9076436942587;2331.522037982218;2333.6966194394704;2295.4031951692514;2299.9080036798673;2322.036354912709;2326.1742081561056;2326.8254880883915;2266.8186545076355;2274.943126421836;2277.7949984501474;2292.08316673332;2292.449812045114;8643.481391116553;8794.12058794122;8877.378583499158;8884.20042196199;8886.066962968924;5282.0756367635895;5381.112116500773;5390.00284947286;5411.540019098342;5418.647787893814;3242.96757032429;3366.224587039388;3460.3944309745693;3531.4526248431534;3561.8753343632848;1106.2975010868076;1111.1222134513725;2156.1698745982753;2228.1533017453426;2232.3860938242115;12324;12377.504899804087;12406.131570790048;12418.627441176688;12451.128421010533;4391.275439552502;4459.710118842265;4566.292224705176;4592;4656.208444564432;9827.606895724233;9850.80298394028;9884.703458896245;9893.703188904345;9931;5319.813806516753;5334.279872217278;5347.358317001985;5355.3841308249275;5367.382750983609;4386.342048692722;4696.107739529479;4863.10032643962;4910.680805747615;5023.422306434733;3698.6856117230336;3746.119661879456;3782.6973842092566;3879.573246942834;3879.7866117363815;1165.4580620011736;1165.6328256599145;1179.9351035693119;1191.4340688173222;1205.4876677412065;834.9582520874053;852.8507511185518;938.1275413865171;962.8844538655406;963.7397902566267;5803.88392232153;5908.586398952118;5987.520998320211;5990.071538911476;6063.6690201907595;435.9149965756647;436.8121707665671;444.6420631391696;445.3609070983085;452.04167165608465;3938.980305098456;3968.0675041365257;3997.360422332471;4003.5195776507007;4025.657819085352;10785.245032847783;11098.722531936766;11183.776324473627;11239.269447486051;11272.887271127347;11113.666590002313;11127.554897804159;11149.609763658233;11179.105671546256;11228.382438965771;7706.730264440717;8052.59737013147;8069.798255043671;8263.214994575506;8396.454230475;5883.558733094949;5925.140854575976;6003.0695242237525;6058;6108.6945652716295;10107.494625268855;10107.494625268855;10111.191104711459;10157.238207134642;10294.279400441897;9827.31208815376;10158.18734501253;10204.795904081728;10339.844902326622;10440.42577658236;7057.470689698396;7517.849643007218;7668.693252269847;7692.538447693157;7849.843003140019;8558.272546833588;8589.44168629037;8590.65637374498;8597.140285971353;8606.65573377058;7225.819354516179;7490.625468726651;7567.886481702669;7611.162772094955;7641.044869391326;7449.664765085476;7555.13115991668;7628.313451789366;7785.532868027936;7913.169117242837;6896.827579310558;6964.895526567207;7013.929860701328;7027.262137475492;7034.2965703429245;5061;5121.41103773056;5151.5106064923775;5164.018836421068;5188.9740551297;5023.522765337287;5032.924506132485;5138.203578445347;5175.404828444777;5445.1832225166545 05:52:13 INFO - PROCESS | 25719 | |4;prototype.html;330.89907578188655;337.40448109087464;342.1855982761029;345.877213589176;349.4967247164082;5637.548996080314;5674.716264186794;5683.261176047118;5694.515966142878;5724.9141262880985;5557.694326812024;5575.637583557076;5582.888342233153;5584.4136365681525;5636.0136976029235;4191.1617676464675;4288.914221715564;4362.825486980517;4390.385346051556;4393.209222339978;4356.215881141393;4365.934510982338;4372;4400.437844565181;4402.00954785174;4377.233984052794;4377.890552736175;4400.97799511002;4407.206702793496;4409.713368631029;4319.071399649075;4366.5851744084575;4384.758838263894;4388.86833394997;4399.73601583906;3849.576546579874;3863.5897897267578;3867.1298957734566;3874.6319099685484;3875.8643447479485;5455.18172274158;5470.56235501159;5483.862903427446;5495.477929596682;5510.283663123809;4830.420349558076;4922.286268491084;4990.476000019982;5017.641708397047;5039.168537191359;5817.243758311435;5845.7369418376275;5859.648421094706;5866.325372582165;5874.32445268791;4280.79539037396;4281.272183728774;4293.540196333231;4296.5059018213;4317.784110794448;6000.579959402844;6042.6978651067275;6093.634381937098;6099.817005489843;6109.419605137549;4279.893002674896;4304.870853874389;4305.91388172241;4312.849050283287;4313.511838415741;4349.543297953669;4357.150355680612;4361.694681372273;4372.366006928977;4378.890527736832;4807.663463557517;4958.776855041532;4966.070018688991;4990.351254336985;4998.825041123543;5838.79564215259;5847.9415205848245;5855.765769369177;5879.970600147058;5935.436133567304;1504.1877386211324;1523.223156190351;1532.9540113796604;1546.1650708617221;1548.3651702801797;954.4464210757744;956.2493442647627;956.6030097509456;968.2592816495387;1023.3399457349967;5594.412586678422;5680.8863822723315;5683.630564013409;5689;5695.323198096888;5967.313758917693;5971.954907891101;5980.8803823924145;5990.400959903975;6076.848078798065;5443.537299329601;5629.016621190775;5660.688662123623;5660.716964151776;5681.460261275172;3163.402481746703;3195.440797860365;3204.6540453009793;3214.8392580370887;3219.82290973994;5923.644581325048;6128.1726966858905;6176.166217560662;6185.381461853779;6192.845178870564;6040.697965101727;6047.969760151171;6078.422549857756;6092.817215483543;6116.143739876421;6097.298810636745;6166.876662466726;6168.9691551541955;6172.598781079216;6187.876242475125;5716.79991200306;5856.209411729362;5867.9413205869105;5874.265716785402;5952.494038006818;5944.702764861826;5974.133750606225;5975.342712301556;6001.039833626599;6011.669358185167;5851.21008663825;6039.516838652985;6081.665508397081;6114.57197996136;6235.594686345373;4152.4601801765575;4170.395292682605;4185.6232939035635;4189.455370801777;4194.832206711697;5996.430339117951;6011.368806275453;6034.63792172471;6043.2748070231855;6048.879022419439;5585.832425027255;5896.410358964069;5923.822285331447;5927.31835838884;5941.792037278675;5934.9109763354445;5935.792247271324;5944.9405505946115;5991.820245392645;6023.45788879003;5252.527272545489;5849.94150058511;5886.529077673861;5904.468597826216;5942.821715348547;5908.113782932594;5958.582899197015;5972;5991.490723288569;6003.609765365237;5830.154627578892;5879.20630714848;5939.7624095037445;5940.5940594059475;5963.642181469126 05:52:13 INFO - PROCESS | 25719 | |5;yui.html;813.8168911994802;835.8495470815253;841.8711778254303;851.0808327006833;878.1525827576387;15549.222538873053;16728.079955602436;16732.83267167328;16906.66186676267;16937.3225070997;14262.928685356559;14320.42718291267;14365.78451323231;14370.353334099964;14465.566033019026;797.6051854332113;800.0519384529351;803.8432505661399;803.9437239393245;804.806846356873;798.7963069417291;799.940004499662;822.8560001999656;825.6903661127077;832.7876391520153;873.9781505462382;876.2639382918347;876.4565969099135;876.4697358098355;877.2324216310728;867.9522626255554;868.5613765048641;871.1158174452935;871.376965469689;872.4285592936604;635.777477882742;637.9521535884827;638.1353266324156;638.3265654734254;639.4979940746491;15374.769378459332;16043;16092.275847586887;16114;16143.192840358053;14461.13233206011;14480.565583032527;14492.855071449256;14954;15442.382304707799;12622.368881555978;12933.224006559543;13271.270080145589;13860.93069534656;13966.092204006707;3922.8430862765454;3947.9013024674327;4040.393940908858;4094.6928980326593;4098.8360465581345;83976.58011709963;85262.16320265603;85786.14213857843;85876.57061714651;86597.56701216454;10907.127429805596;11512.827307590393;11642.24325418862;12010.699732506582;12294.385280735927;21318.14727410917;21519.78480215178;21519.892400537898;21793.67309490359;21882.78117218839;8464.915350846535;8566.571671416405;8574.699885503978;8704.260137888225;8725.825483490295;5073.2678193805195;5136.409312928986;5158.226266060046;5165.819196328186;5232.110541208004;3546.733994950389;3613.512175856226;3613.94579081314;3615.439606860941;3619.2218672985437;635.6980434293766;645.122633218822;652.2759736692268;653.3074940563018;656.9343065693488;731.6159016516372;736.6519071540654;764.3732139645548;771.7952909588938;786.1116937860296;9503;9760.5994243212;9845.964079838022;9965;10159.187265018782;645.7481582182952;727.2146082231178;745.1616930952679;764.58712295361;803.5941849366033;4722.716637001791;4898.338724272249;4929.630277729185;4976.730744317213;5071.290019397287;114776.26118694199;116037.41981290039;118503.40748296375;118925;121080;102707.4864625672;104254;105743;106671;106833.46583267034;82992.58503707443;88106.55946720226;88552;89838;94909.5254523723;9625;9971.800563988534;10041.246906481896;10278.640247591298;10292.433916134385;51916.740416297675;51966;52943;54070;54315.45684543104;67490;77209;78578.2142178571;80044.79820807102;81541.18458815335;12835.294058826854;12852;13003.479860805463;13017.21896686202;13124.40940157676;15337.769933450783;15443.536693899201;15741.606459838596;15786.289616967035;16307.347706092098;14516.927415362856;14896.654644944658;15254.466093686668;15281.46514871974;15729.44946926852;14614.634634134232;14718;15193.924030379778;15263.847361526243;15637.452689155825;13704.3833027516;13991.23048232357;14079.366428510946;14202.218877961812;14602.12387256768;11060.944695276472;11169.664910052712;11388.772224555629;12044.457999390224;12126.636200913987;11345.262557933707;12177.573784917486;12356.567520136752;12366.752664946831;12569 05:52:13 INFO - PROCESS | 25719 | __end_tp_report 05:52:13 INFO - PROCESS | 25719 | __start_cc_report 05:52:13 INFO - PROCESS | 25719 | _x_x_mozilla_cycle_collect,369 05:52:13 INFO - PROCESS | 25719 | __end_cc_report 05:52:13 INFO - PROCESS | 25719 | __startTimestamp1469105533308__endTimestamp 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | ------- Summary: start ------- 05:52:13 INFO - PROCESS | 25719 | Number of tests: 6 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | [#0] dojo.html Cycles:165 Average:5424.25 Median:5649.69 stddev:623.45 (11.0%) stddev-sans-first:597.12 05:52:13 INFO - PROCESS | 25719 | Values: 3058.9 3071.9 3093.2 3100.1 3101.8 5347.8 5350.8 5366.0 5444.2 5489.6 5368.0 5414.4 5472.0 5494.4 5504.5 4954.1 4974.9 5010.3 5088.5 5089.1 4987.9 5072.8 5081.7 5108.6 5119.1 4900.7 4944.1 4968.2 5022.6 5023.2 4951.0 4989.2 5018.1 5047.8 5057.7 4954.3 4957.4 4962.0 4976.1 5010.7 5230.8 5417.9 5443.3 5465.3 5498.8 5827.0 5863.5 5876.1 5894.4 5902.2 5878.3 5889.0 5899.4 5910.2 5933.3 5377.9 5405.7 5502.3 5525.2 5543.2 5895.6 5951.0 5958.5 5993.0 5996.9 5694.2 5696.9 5708.4 5720.3 5726.2 5609.3 5778.7 5819.0 5820.9 5820.9 5618.1 5748.5 5793.1 5884.0 5887.7 5862.9 5867.4 5869.7 5869.8 5929.6 4456.8 4457.7 4466.8 4467.2 4511.0 3873.8 3977.5 3997.2 4009.3 4057.2 5678.4 5701.9 5705.2 5714.4 5719.1 5938.4 5962.1 5986.7 6002.2 6002.3 5415.6 5443.8 5486.7 5489.8 5556.7 4846.5 4858.3 4876.9 4877.0 4878.8 5928.7 5929.6 5930.1 5939.7 5945.7 5724.2 5844.4 5869.7 5892.4 5953.4 5943.0 5972.4 5999.3 6035.9 6053.8 5706.6 5743.6 5758.9 5764.0 5766.2 5643.1 5844.5 5864.1 5870.9 5932.1 5747.5 5758.3 5765.2 5776.2 5788.6 5713.4 5721.4 5731.9 5735.1 5737.4 5460.6 5583.8 5618.2 5635.3 5647.2 5637.1 5664.5 5681.7 5694.9 5700.4 5561.1 5641.9 5649.0 5649.7 5676.2 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | [#1] ext.html Cycles:180 Average:64035.30 Median:44428.06 stddev:134720.41 (303.2%) stddev-sans-first:135014.02 05:52:13 INFO - PROCESS | 25719 | Values: 553.3 585.9 602.8 612.5 640.5 39290.8 43495.6 44071.6 44190.8 44366.3 44468.0 44871.0 44910.8 45000.8 45068.3 8916.8 9062.6 9108.8 9115.3 9117.9 9023.3 9113.8 9115.5 9117.5 9131.8 9069.6 9081.2 9090.1 9137.8 9164.6 9088.7 9095.7 9115.7 9126.5 9138.5 9059.0 9117.4 9121.0 9147.9 9170.2 43882.3 44081.6 44182.0 44319.8 44346.6 3493.8 3637.5 3673.5 3714.7 3792.5 30903.7 31297.0 31713.4 31719.8 32504.2 4432.6 4476.3 4489.9 4530.6 4663.5 250627.0 251040.0 252177.0 252342.0 252591.0 53700.5 54019.5 54129.8 54348.7 54349.2 64927.4 65483.3 65814.0 65962.7 66088.7 16116.9 17395.5 17749.1 17752.0 17937.9 13132.2 13171.8 13174.7 13279.9 13327.3 20231.9 20353.6 20499.8 20584.2 20753.7 7154.8 7408.6 7453.4 7557.3 7576.8 951.8 1053.0 1126.6 1127.8 1151.0 33871.0 34214.7 34274.8 34661.7 34701.0 1043.3 1096.9 1103.4 1123.9 1163.5 16218.7 17279.7 17289.7 17306.8 17458.7 656476.0 667722.0 671000.0 679649.0 681207.0 63354.4 63755.0 63905.0 64150.2 64177.0 1342.9 1365.4 1371.9 1374.2 1397.7 31211.2 32101.4 32858.0 32947.8 33089.3 53449.7 53669.7 53687.7 53778.5 53815.0 494548.0 494684.0 495796.0 497290.0 499823.0 29414.6 29577.9 29892.0 29995.9 30372.2 50286.0 51260.5 51807.0 52013.0 52331.7 43938.6 45445.0 45711.4 45777.3 46453.8 44388.1 45072.0 45195.0 45834.5 46184.5 43395.0 43506.8 44076.8 44289.6 44705.6 36704.6 38360.6 39427.0 39843.8 39942.8 28792.0 29297.1 29739.9 29803.7 29959.4 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | [#2] jquery.html Cycles:180 Average:30352.48 Median:19684.35 stddev:88014.78 (447.1%) stddev-sans-first:88232.89 05:52:13 INFO - PROCESS | 25719 | Values: 368.1 386.7 391.9 394.8 403.2 17652.2 20009.8 20032.5 20273.6 20299.3 18813.2 19166.6 19189.1 19392.8 19633.0 5616.2 5730.5 5738.5 5846.6 5912.0 5746.9 5748.4 5762.3 5772.9 5782.9 5289.7 5506.2 5540.9 5688.0 5728.7 5707.6 5744.5 5764.0 5984.3 6354.2 5661.7 5750.6 5784.3 5785.7 5791.9 13985.1 16272.8 20452.7 21057.2 21413.9 2351.9 2534.1 2580.1 2770.3 2926.3 10113.4 10136.7 10175.0 10352.4 14127.8 1775.6 1833.5 1858.7 1876.7 1901.7 84136.6 84353.6 86795.0 86809.6 87599.6 9993.0 10654.8 10793.9 10894.2 10981.4 15192.8 15247.5 15262.3 15332.0 15357.2 7568.3 7617.4 7965.7 8377.2 8446.2 7488.2 7599.8 7754.5 7843.2 8072.7 4440.2 4605.7 4618.9 4739.6 4822.9 1870.1 1883.3 1912.9 1974.9 1997.1 837.4 848.4 914.8 925.6 1014.2 18498.8 19592.8 19658.0 19767.3 19865.7 955.2 962.6 974.5 988.5 1025.9 10539.4 11073.5 11093.9 11161.1 11191.7 524299.0 524304.0 532297.0 543692.0 544421.0 92511.0 96036.5 96327.5 96788.5 97758.0 980.3 1027.5 1033.7 1048.6 1048.8 16410.2 16847.6 17492.5 17761.0 18154.5 33123.0 38982.0 41895.0 44061.6 44722.0 59184.7 60288.7 60783.4 61366.7 61487.4 7071.5 7462.6 7487.6 8061.4 8404.3 9409.0 12921.4 13557.3 13959.7 14223.2 11807.5 11927.3 11984.2 12037.6 12200.3 11296.0 11390.8 11893.7 11964.7 12373.8 7121.8 12036.4 12216.4 12492.0 12762.7 7395.4 7525.5 7623.4 7777.2 7841.4 10689.6 11457.1 11664.3 11764.9 11976.6 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | [#3] mootools.html Cycles:180 Average:5787.82 Median:4779.60 stddev:3300.03 (69.0%) stddev-sans-first:3293.60 05:52:13 INFO - PROCESS | 25719 | Values: 1506.5 1516.8 1683.8 1771.8 1815.9 7887.6 8248.1 8494.7 9082.4 9090.2 8579.8 8632.7 8650.0 8658.9 8663.8 2311.7 2352.3 2352.4 2353.1 2353.7 2294.1 2296.1 2365.9 2372.6 2377.5 2280.1 2285.9 2308.9 2331.5 2333.7 2295.4 2299.9 2322.0 2326.2 2326.8 2266.8 2274.9 2277.8 2292.1 2292.4 8643.5 8794.1 8877.4 8884.2 8886.1 5282.1 5381.1 5390.0 5411.5 5418.6 3243.0 3366.2 3460.4 3531.5 3561.9 1106.3 1111.1 2156.2 2228.2 2232.4 12324.0 12377.5 12406.1 12418.6 12451.1 4391.3 4459.7 4566.3 4592.0 4656.2 9827.6 9850.8 9884.7 9893.7 9931.0 5319.8 5334.3 5347.4 5355.4 5367.4 4386.3 4696.1 4863.1 4910.7 5023.4 3698.7 3746.1 3782.7 3879.6 3879.8 1165.5 1165.6 1179.9 1191.4 1205.5 835.0 852.9 938.1 962.9 963.7 5803.9 5908.6 5987.5 5990.1 6063.7 435.9 436.8 444.6 445.4 452.0 3939.0 3968.1 3997.4 4003.5 4025.7 10785.2 11098.7 11183.8 11239.3 11272.9 11113.7 11127.6 11149.6 11179.1 11228.4 7706.7 8052.6 8069.8 8263.2 8396.5 5883.6 5925.1 6003.1 6058.0 6108.7 10107.5 10107.5 10111.2 10157.2 10294.3 9827.3 10158.2 10204.8 10339.8 10440.4 7057.5 7517.8 7668.7 7692.5 7849.8 8558.3 8589.4 8590.7 8597.1 8606.7 7225.8 7490.6 7567.9 7611.2 7641.0 7449.7 7555.1 7628.3 7785.5 7913.2 6896.8 6964.9 7013.9 7027.3 7034.3 5061.0 5121.4 5151.5 5164.0 5189.0 5023.5 5032.9 5138.2 5175.4 5445.2 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | [#4] prototype.html Cycles:180 Average:4944.46 Median:5681.17 stddev:1450.86 (25.5%) stddev-sans-first:1413.00 05:52:13 INFO - PROCESS | 25719 | Values: 330.9 337.4 342.2 345.9 349.5 5637.5 5674.7 5683.3 5694.5 5724.9 5557.7 5575.6 5582.9 5584.4 5636.0 4191.2 4288.9 4362.8 4390.4 4393.2 4356.2 4365.9 4372.0 4400.4 4402.0 4377.2 4377.9 4401.0 4407.2 4409.7 4319.1 4366.6 4384.8 4388.9 4399.7 3849.6 3863.6 3867.1 3874.6 3875.9 5455.2 5470.6 5483.9 5495.5 5510.3 4830.4 4922.3 4990.5 5017.6 5039.2 5817.2 5845.7 5859.6 5866.3 5874.3 4280.8 4281.3 4293.5 4296.5 4317.8 6000.6 6042.7 6093.6 6099.8 6109.4 4279.9 4304.9 4305.9 4312.8 4313.5 4349.5 4357.2 4361.7 4372.4 4378.9 4807.7 4958.8 4966.1 4990.4 4998.8 5838.8 5847.9 5855.8 5880.0 5935.4 1504.2 1523.2 1533.0 1546.2 1548.4 954.4 956.2 956.6 968.3 1023.3 5594.4 5680.9 5683.6 5689.0 5695.3 5967.3 5972.0 5980.9 5990.4 6076.8 5443.5 5629.0 5660.7 5660.7 5681.5 3163.4 3195.4 3204.7 3214.8 3219.8 5923.6 6128.2 6176.2 6185.4 6192.8 6040.7 6048.0 6078.4 6092.8 6116.1 6097.3 6166.9 6169.0 6172.6 6187.9 5716.8 5856.2 5867.9 5874.3 5952.5 5944.7 5974.1 5975.3 6001.0 6011.7 5851.2 6039.5 6081.7 6114.6 6235.6 4152.5 4170.4 4185.6 4189.5 4194.8 5996.4 6011.4 6034.6 6043.3 6048.9 5585.8 5896.4 5923.8 5927.3 5941.8 5934.9 5935.8 5944.9 5991.8 6023.5 5252.5 5849.9 5886.5 5904.5 5942.8 5908.1 5958.6 5972.0 5991.5 6003.6 5830.2 5879.2 5939.8 5940.6 5963.6 05:52:13 INFO - PROCESS | 25719 | 05:52:13 INFO - PROCESS | 25719 | [#5] yui.html Cycles:180 Average:21824.70 Median:3994.15 stddev:31384.73 (785.8%) stddev-sans-first:31433.12 05:52:13 INFO - PROCESS | 25719 | Values: 813.8 835.8 841.9 851.1 878.2 15549.2 16728.1 16732.8 16906.7 16937.3 14262.9 14320.4 14365.8 14370.4 14465.6 797.6 800.1 803.8 803.9 804.8 798.8 799.9 822.9 825.7 832.8 874.0 876.3 876.5 876.5 877.2 868.0 868.6 871.1 871.4 872.4 635.8 638.0 638.1 638.3 639.5 15374.8 16043.0 16092.3 16114.0 16143.2 14461.1 14480.6 14492.9 14954.0 15442.4 12622.4 12933.2 13271.3 13860.9 13966.1 3922.8 3947.9 4040.4 4094.7 4098.8 83976.6 85262.2 85786.1 85876.6 86597.6 10907.1 11512.8 11642.2 12010.7 12294.4 21318.1 21519.8 21519.9 21793.7 21882.8 8464.9 8566.6 8574.7 8704.3 8725.8 5073.3 5136.4 5158.2 5165.8 5232.1 3546.7 3613.5 3613.9 3615.4 3619.2 635.7 645.1 652.3 653.3 656.9 731.6 736.7 764.4 771.8 786.1 9503.0 9760.6 9846.0 9965.0 10159.2 645.7 727.2 745.2 764.6 803.6 4722.7 4898.3 4929.6 4976.7 5071.3 114776.3 116037.4 118503.4 118925.0 121080.0 102707.5 104254.0 105743.0 106671.0 106833.5 82992.6 88106.6 88552.0 89838.0 94909.5 9625.0 9971.8 10041.2 10278.6 10292.4 51916.7 51966.0 52943.0 54070.0 54315.5 67490.0 77209.0 78578.2 80044.8 81541.2 12835.3 12852.0 13003.5 13017.2 13124.4 15337.8 15443.5 15741.6 15786.3 16307.3 14516.9 14896.7 15254.5 15281.5 15729.4 14614.6 14718.0 15193.9 15263.8 15637.5 13704.4 13991.2 14079.4 14202.2 14602.1 11060.9 11169.7 11388.8 12044.5 12126.6 11345.3 12177.6 12356.6 12366.8 12569.0 05:52:13 INFO - PROCESS | 25719 | -------- Summary: end -------- 05:52:13 INFO - PROCESS | 25719 | 05:52:14 INFO - TEST-INFO | 25719: exit 0 05:52:14 INFO - TEST-OK | dromaeo_css | took 1111658ms 05:52:14 INFO - TEST-START | kraken 05:52:14 INFO - operating with platform_type : linux_ 05:52:14 INFO - Initialising browser for kraken test... 05:52:14 INFO - TEST-INFO | started process 25967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYBf6oz/profile http://localhost:48809/getInfo.html) 05:52:18 INFO - PROCESS | 25967 | __metrics Screen width/height:1600/1200 05:52:18 INFO - PROCESS | 25967 | colorDepth:24 05:52:18 INFO - PROCESS | 25967 | Browser inner width/height: 1024/697 05:52:18 INFO - PROCESS | 25967 | __metrics 05:52:19 ERROR - PROCESS | 25967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:52:19 INFO - TEST-INFO | 25967: exit 0 05:52:19 INFO - Browser initialized. 05:52:19 INFO - Running cycle 1/1 for kraken test... 05:52:19 INFO - TEST-INFO | started process 26086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYBf6oz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:31 INFO - PROCESS | 26086 | RSS: Main: 167329792 05:52:31 INFO - PROCESS | 26086 | 05:52:34 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48809/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:35 INFO - PROCESS | 26086 | RSS: Main: 173154304 05:52:35 INFO - PROCESS | 26086 | 05:52:37 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48809/tests/kraken/driver.html?testName=audio-dft) 05:52:38 INFO - PROCESS | 26086 | RSS: Main: 171925504 05:52:38 INFO - PROCESS | 26086 | 05:52:41 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48809/tests/kraken/driver.html?testName=audio-fft) 05:52:41 INFO - PROCESS | 26086 | RSS: Main: 167809024 05:52:41 INFO - PROCESS | 26086 | 05:52:43 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48809/tests/kraken/driver.html?testName=audio-oscillator) 05:52:44 INFO - PROCESS | 26086 | RSS: Main: 169132032 05:52:44 INFO - PROCESS | 26086 | 05:52:46 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:47 INFO - PROCESS | 26086 | RSS: Main: 169357312 05:52:47 INFO - PROCESS | 26086 | 05:52:50 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48809/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:51 INFO - PROCESS | 26086 | RSS: Main: 169803776 05:52:51 INFO - PROCESS | 26086 | 05:52:54 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48809/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:55 INFO - PROCESS | 26086 | RSS: Main: 167387136 05:52:55 INFO - PROCESS | 26086 | 05:52:58 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48809/tests/kraken/driver.html?testName=json-parse-financial) 05:52:58 INFO - PROCESS | 26086 | RSS: Main: 168357888 05:52:58 INFO - PROCESS | 26086 | 05:53:00 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:00 INFO - PROCESS | 26086 | RSS: Main: 168808448 05:53:00 INFO - PROCESS | 26086 | 05:53:02 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:03 INFO - PROCESS | 26086 | RSS: Main: 169185280 05:53:03 INFO - PROCESS | 26086 | 05:53:05 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:06 INFO - PROCESS | 26086 | RSS: Main: 169783296 05:53:06 INFO - PROCESS | 26086 | 05:53:08 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:09 INFO - PROCESS | 26086 | RSS: Main: 169869312 05:53:09 INFO - PROCESS | 26086 | 05:53:12 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:12 INFO - PROCESS | 26086 | RSS: Main: 169566208 05:53:12 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | Cycle 1(1): loaded http://localhost:48809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48809/tests/kraken/driver.html?testName=ai-astar) 05:53:14 INFO - PROCESS | 26086 | RSS: Main: 170184704 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | __start_tp_report 05:53:14 INFO - PROCESS | 26086 | _x_x_mozilla_page_load 05:53:14 INFO - PROCESS | 26086 | _x_x_mozilla_page_load_details 05:53:14 INFO - PROCESS | 26086 | |i|pagename|runs| 05:53:14 INFO - PROCESS | 26086 | |0;ai-astar;105;113;106;112;114;114;114;113;113;112 05:53:14 INFO - PROCESS | 26086 | |1;audio-beat-detection;155;121;144;180;122;147;148;119;182;117 05:53:14 INFO - PROCESS | 26086 | |2;audio-dft;162;162;163;161;163;164;170;164;162;163 05:53:14 INFO - PROCESS | 26086 | |3;audio-fft;87;75;75;166;77;76;75;77;167;75 05:53:14 INFO - PROCESS | 26086 | |4;audio-oscillator;90;83;158;84;85;84;147;84;85;143 05:53:14 INFO - PROCESS | 26086 | |5;imaging-gaussian-blur;118;117;117;121;120;119;117;118;118;118 05:53:14 INFO - PROCESS | 26086 | |6;imaging-darkroom;148;148;147;148;147;148;147;147;147;149 05:53:14 INFO - PROCESS | 26086 | |7;imaging-desaturate;96;95;96;96;98;100;101;96;96;95 05:53:14 INFO - PROCESS | 26086 | |8;json-parse-financial;50;51;51;51;51;50;56;52;51;51 05:53:14 INFO - PROCESS | 26086 | |9;json-stringify-tinderbox;61;63;62;62;62;62;62;63;62;62 05:53:14 INFO - PROCESS | 26086 | |10;stanford-crypto-aes;82;77;78;75;76;76;74;84;81;79 05:53:14 INFO - PROCESS | 26086 | |11;stanford-crypto-ccm;127;126;125;120;120;130;123;140;148;140 05:53:14 INFO - PROCESS | 26086 | |12;stanford-crypto-pbkdf2;157;161;159;157;159;159;157;155;156;160 05:53:14 INFO - PROCESS | 26086 | |13;stanford-crypto-sha256-iterative;64;64;72;68;71;61;66;62;63;63 05:53:14 INFO - PROCESS | 26086 | __end_tp_report 05:53:14 INFO - PROCESS | 26086 | __start_cc_report 05:53:14 INFO - PROCESS | 26086 | _x_x_mozilla_cycle_collect,920 05:53:14 INFO - PROCESS | 26086 | __end_cc_report 05:53:14 INFO - PROCESS | 26086 | __startTimestamp1469105594604__endTimestamp 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | ------- Summary: start ------- 05:53:14 INFO - PROCESS | 26086 | Number of tests: 14 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.31 (2.9%) stddev-sans-first:2.50 05:53:14 INFO - PROCESS | 26086 | Values: 105.0 113.0 106.0 112.0 114.0 114.0 114.0 113.0 113.0 112.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:147.50 stddev:24.15 (16.4%) stddev-sans-first:25.26 05:53:14 INFO - PROCESS | 26086 | Values: 155.0 121.0 144.0 180.0 122.0 147.0 148.0 119.0 182.0 117.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.50 (1.5%) stddev-sans-first:2.60 05:53:14 INFO - PROCESS | 26086 | Values: 162.0 162.0 163.0 161.0 163.0 164.0 170.0 164.0 162.0 163.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:37.86 (50.1%) stddev-sans-first:40.04 05:53:14 INFO - PROCESS | 26086 | Values: 87.0 75.0 75.0 166.0 77.0 76.0 75.0 77.0 167.0 75.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:84.00 stddev:31.35 (37.3%) stddev-sans-first:32.82 05:53:14 INFO - PROCESS | 26086 | Values: 90.0 83.0 158.0 84.0 85.0 84.0 147.0 84.0 85.0 143.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.34 (1.1%) stddev-sans-first:1.41 05:53:14 INFO - PROCESS | 26086 | Values: 118.0 117.0 117.0 121.0 120.0 119.0 117.0 118.0 118.0 118.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 05:53:14 INFO - PROCESS | 26086 | Values: 148.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 149.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:2.08 (2.2%) stddev-sans-first:2.18 05:53:14 INFO - PROCESS | 26086 | Values: 96.0 95.0 96.0 96.0 98.0 100.0 101.0 96.0 96.0 95.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:1.71 (3.4%) stddev-sans-first:1.74 05:53:14 INFO - PROCESS | 26086 | Values: 50.0 51.0 51.0 51.0 51.0 50.0 56.0 52.0 51.0 51.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 05:53:14 INFO - PROCESS | 26086 | Values: 61.0 63.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:3.26 (4.2%) stddev-sans-first:3.15 05:53:14 INFO - PROCESS | 26086 | Values: 82.0 77.0 78.0 75.0 76.0 76.0 74.0 84.0 81.0 79.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:128.50 stddev:9.56 (7.4%) stddev-sans-first:10.08 05:53:14 INFO - PROCESS | 26086 | Values: 127.0 126.0 125.0 120.0 120.0 130.0 123.0 140.0 148.0 140.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:159.00 stddev:1.89 (1.2%) stddev-sans-first:1.96 05:53:14 INFO - PROCESS | 26086 | Values: 157.0 161.0 159.0 157.0 159.0 159.0 157.0 155.0 156.0 160.0 05:53:14 INFO - PROCESS | 26086 | 05:53:14 INFO - PROCESS | 26086 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:3.78 (5.8%) stddev-sans-first:3.97 05:53:14 INFO - PROCESS | 26086 | Values: 64.0 64.0 72.0 68.0 71.0 61.0 66.0 62.0 63.0 63.0 05:53:14 INFO - PROCESS | 26086 | -------- Summary: end -------- 05:53:14 INFO - PROCESS | 26086 | 05:53:15 INFO - TEST-INFO | 26086: exit 0 05:53:15 INFO - TEST-OK | kraken | took 61559ms 05:53:15 INFO - SUITE-END | took 1173s 05:53:15 INFO - Completed test suite (00:19:33) 05:53:15 INFO - javascript benchmark 05:53:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7416.648700973088, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.8929387471435, 3071.8924837630675, 3093.242155671861, 3100.1474594486513, 3101.7673674474404, 5347.786088556458, 5350.839474815757, 5366.0, 5444.1561557958485, 5489.560835133189, 5368.0, 5414.35027796664, 5472.0, 5494.423085576017, 5504.4770746778995, 4954.083494553501, 4974.850754477362, 5010.323606313155, 5088.516590923857, 5089.058524173021, 4987.925181122286, 5072.822451214208, 5081.7459127043685, 5108.6168537359845, 5119.104156772569, 4900.705957642553, 4944.085344211332, 4968.22992436173, 5022.598192144638, 5023.246513023039, 4950.9504904950845, 4989.151844186497, 5018.121828679967, 5047.798088076473, 5057.747112644353, 4954.3063971044085, 4957.380327459067, 4961.9751901240625, 4976.104301225778, 5010.749462526859, 5230.843074707765, 5417.945820541783, 5443.265159203496, 5465.262189604432, 5498.752556134984, 5826.9708651456895, 5863.5309175265875, 5876.059830427154, 5894.351621321651, 5902.203202567642, 5878.265216847894, 5889.02831032879, 5899.380565040652, 5910.172575839343, 5933.3473317934995, 5377.892442151135, 5405.675659460445, 5502.312210973629, 5525.171224316345, 5543.196236545678, 5895.646261224255, 5950.958582248176, 5958.523318134538, 5992.970035149797, 5996.910046349309, 5694.231278777394, 5696.943030569641, 5708.429157084342, 5720.3421606515785, 5726.198332233491, 5609.349913740618, 5778.653280803165, 5818.981678206382, 5820.912686309709, 5820.941790582125, 5618.073017952074, 5748.540116790647, 5793.102069179284, 5883.970580147072, 5887.735051922674, 5862.912056319158, 5867.413258674183, 5869.706514674249, 5869.765209391662, 5929.584929055011, 4456.799444025027, 4457.710248833815, 4466.821327146943, 4467.195904737114, 4511.0, 3873.825677844504, 3977.463042489285, 3997.2205419942834, 4009.3184158693093, 4057.229126465962, 5678.4037676044245, 5701.942980570224, 5705.22979397776, 5714.428557144252, 5719.056355701346, 5938.376470470625, 5962.07587823888, 5986.700664966735, 6002.219711437572, 6002.339742628307, 5415.620906536505, 5443.755031023614, 5486.6982315973, 5489.835304940858, 5556.72216389187, 4846.539578740014, 4858.295547145714, 4876.926846097312, 4876.975615121902, 4878.756062196876, 5928.7332070056955, 5929.584929054925, 5930.080837470113, 5939.732712027969, 5945.702714864239, 5724.227229324071, 5844.357120716632, 5869.6771677558145, 5892.35184129754, 5953.404659534012, 5943.049112142036, 5972.432618901197, 5999.310079340931, 6035.9437098506705, 6053.75784968614, 5706.600537962303, 5743.62666426681, 5758.8848223034465, 5764.048931926185, 5766.192733017297, 5643.068893632669, 5844.47399734026, 5864.091065884794, 5870.911936320873, 5932.0508718604815, 5747.51146152565, 5758.280214973129, 5765.221695071112, 5776.162456443708, 5788.623739456922, 5713.428657134419, 5721.370649228665, 5731.942680573141, 5735.139729040678, 5737.426257374229, 5460.5904557159165, 5583.776648933997, 5618.2415373924, 5635.295588051494, 5647.1529270609735, 5637.069883469346, 5664.546836253172, 5681.744321505459, 5694.943050569441, 5700.401457847032, 5561.054620714569, 5641.9435805641415, 5649.0, 5649.68926709035, 5676.20533125371], "value": 5381.066795119715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3347869273447, 585.8769658371742, 602.7853874442998, 612.5405945540845, 640.5388120553206, 39290.803545982264, 43495.56504434955, 44071.55928440714, 44190.77904610476, 44366.33450498245, 44468.0, 44871.0, 44910.77544612272, 45000.77499612497, 45068.323975140396, 8916.821663566725, 9062.592183351731, 9108.772280693003, 9115.27077833775, 9117.863232051524, 9023.278137748965, 9113.772155696095, 9115.49864757438, 9117.45295282282, 9131.817363652723, 9069.637214511411, 9081.18269355758, 9090.13643703847, 9137.771555711128, 9164.633414663438, 9088.681896133636, 9095.681651142178, 9115.680951166743, 9126.498042607654, 9138.451692898414, 9059.0, 9117.361784675075, 9121.0, 9147.908520914772, 9170.17468427838, 43882.341764873556, 44081.55918440839, 44182.0, 44319.77840110811, 44346.55653443457, 3493.7903725776537, 3637.5271214741915, 3673.540807399075, 3714.7213958952916, 3792.4880141180865, 30903.690963090306, 31297.0, 31713.365732685448, 31719.84140079308, 32504.18739531507, 4432.578905004019, 4476.328550717386, 4489.887752806173, 4530.614897733697, 4663.533646635343, 250627.0, 251040.0, 252177.0, 252342.0, 252591.0, 53700.462995370326, 54019.45980540223, 54129.752214867236, 54348.72825635847, 54349.1847622286, 64927.350726493074, 65483.34516654868, 65814.0, 65962.67018664876, 66088.71290296764, 16116.919415402848, 17395.47813565595, 17749.11254437273, 17752.0, 17937.910310448366, 13132.212067275994, 13171.802422963472, 13174.670633234246, 13279.867201328056, 13327.333633318296, 20231.898840505703, 20353.59292814165, 20499.795002050087, 20584.176632934814, 20753.688694669592, 7154.821129471701, 7408.591887826735, 7453.440991925628, 7557.2820582044615, 7576.772696818994, 951.752544338477, 1052.984205236922, 1126.6225814352283, 1127.7518945831903, 1151.0043812102472, 33871.0, 34214.657853421144, 34274.82862585671, 34661.65338346584, 34701.0, 1043.3426941027255, 1096.9122470202365, 1103.3876198709793, 1123.8763735989035, 1163.4531770068054, 16218.67562648764, 17279.7408038877, 17289.654206916042, 17306.826931730775, 17458.65082698339, 656476.0, 667722.0, 671000.0, 679649.0, 681207.0, 63354.36645633577, 63755.0, 63905.0, 64150.22647961706, 64177.0, 1342.9059965802496, 1365.4196966289287, 1371.9245441500814, 1374.202962281874, 1397.699494608664, 31211.219719507193, 32101.35797284088, 32858.0, 32947.79212736835, 33089.33821323608, 53449.73275133599, 53669.73165134149, 53687.73156134194, 53778.462215377345, 53815.0, 494548.0, 494684.0, 495796.0, 497290.0, 499823.0, 29414.558781617863, 29577.85211073931, 29892.0, 29995.850020749756, 30372.24069398283, 50286.0, 51260.48739512557, 51807.0, 52013.0, 52331.73834130805, 43938.56061439345, 45445.0, 45711.35182018964, 45777.313340300585, 46453.767731161126, 44388.112237754416, 45072.0, 45195.0, 45834.54165458303, 46184.53815461937, 43395.0, 43506.78246608747, 44076.77961610172, 44289.557104429834, 44705.55294447144, 36704.63295367012, 38360.616393835706, 39427.0, 39843.80078099591, 39942.80028599955, 28792.0, 29297.121086367442, 29739.851300743358, 29803.701962980093, 29959.40487141557], "value": 20836.34528181904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.11284803623255, 386.70803543324774, 391.8785176595256, 394.7710328009755, 403.2398928020682, 17652.20565074573, 20009.799902000974, 20032.4991875203, 20273.59452810943, 20299.289524866632, 18813.153408096634, 19166.61666766664, 19189.136488858, 19392.806071939278, 19633.0, 5616.213730077792, 5730.541556675456, 5738.483536481705, 5846.619969701977, 5911.970440147793, 5746.913796293038, 5748.367679555246, 5762.250907382035, 5772.942270577303, 5782.855428614276, 5289.68261904285, 5506.174073888908, 5540.889182216353, 5688.0, 5728.68492232927, 5707.601637598794, 5744.454276843714, 5763.991301522259, 5984.3417224105315, 6354.205724284465, 5661.66030038199, 5750.597458177929, 5784.2769653793275, 5785.710714464302, 5791.913121303184, 13985.090969086978, 16272.83727162725, 20452.693209601868, 21057.157713691435, 21413.92930353492, 2351.8588884666974, 2534.1003943600126, 2580.135654555726, 2770.265879541923, 2926.25380527964, 10113.436651222217, 10136.746581335525, 10175.0, 10352.430616316175, 14127.799137073362, 1775.5916139288036, 1833.5049536625036, 1858.7304840798145, 1876.7372567840514, 1901.7242499837446, 84136.57931710363, 84353.57823210907, 86795.0, 86809.56595216984, 87599.56200218959, 9993.0, 10654.840177397346, 10793.946030269799, 10894.237403381845, 10981.3960232188, 15192.848071519364, 15247.542573722805, 15262.31319590621, 15332.0, 15357.232138393036, 7568.318851303409, 7617.390608751398, 7965.681372745025, 8377.162283771575, 8446.197611226924, 7488.213737557587, 7599.848003039909, 7754.534727916343, 7843.215678432111, 8072.717454889051, 4440.2007638625355, 4605.723656580616, 4618.884527886763, 4739.597134243559, 4822.927656085161, 1870.0910110958732, 1883.2749391484103, 1912.913918873654, 1974.8518861085477, 1997.131247907165, 837.380338549469, 848.3510114762212, 914.7850255190025, 925.5696101312788, 1014.1633152648947, 18498.81501184971, 19592.804071959097, 19658.0, 19767.308144214883, 19865.702014469796, 955.245356168619, 962.6101428921298, 974.512743628186, 988.5304480371766, 1025.9025392587691, 10539.367637941748, 11073.50169242386, 11093.889061109447, 11161.107111431065, 11191.720206994727, 524299.0, 524304.0, 532297.0, 543692.0, 544421.0, 92511.0, 96036.51981740046, 96327.51836240773, 96788.51605741926, 97758.0, 980.3235767320526, 1027.5222021760067, 1033.6743925663393, 1048.570086264628, 1048.7902419516126, 16410.179491025163, 16847.578810529834, 17492.47522574325, 17761.0, 18154.546136346697, 33123.0, 38982.0, 41895.0, 44061.559384407024, 44722.0, 59184.70407647934, 60288.69855650693, 60783.39216607954, 61366.69316653388, 61487.38512614817, 7071.504994650325, 7462.552246865205, 7487.588182650006, 8061.395395345256, 8404.327653787805, 9408.965013848334, 12921.353932303535, 13557.322133893069, 13959.651008724863, 14223.21772302492, 11807.465029546447, 11927.284362938251, 11984.221025633306, 12037.638870833889, 12200.328981905725, 11295.966725989401, 11390.772184556428, 11893.702657433634, 11964.700882478008, 12373.814392784296, 7121.750738724119, 12036.398180091135, 12216.38918054076, 12492.0, 12762.680932976378, 7395.445341599294, 7525.473216874985, 7623.390128789794, 7777.1833957433655, 7841.372690184886, 10689.572417103229, 11457.083433325148, 11664.300141991507, 11764.941175294069, 11976.58081967127], "value": 9161.350909583452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.5480355893233, 1516.772484127381, 1683.8484536391722, 1771.8139595342498, 1815.9182836772343, 7887.60561971902, 8248.051474080468, 8494.660213591456, 9082.409643373176, 9090.227330676893, 8579.78550536237, 8632.654693812256, 8650.048494665598, 8658.87011694825, 8663.783405414868, 2311.6763653088583, 2352.3413444235644, 2352.4118970257437, 2353.1293421434093, 2353.6587194856734, 2294.139697613395, 2296.115995341797, 2365.9171928982487, 2372.608519594265, 2377.465070359164, 2280.1221529711097, 2285.931422057333, 2308.9076436942587, 2331.522037982218, 2333.6966194394704, 2295.4031951692514, 2299.9080036798673, 2322.036354912709, 2326.1742081561056, 2326.8254880883915, 2266.8186545076355, 2274.943126421836, 2277.7949984501474, 2292.08316673332, 2292.449812045114, 8643.481391116553, 8794.12058794122, 8877.378583499158, 8884.20042196199, 8886.066962968924, 5282.0756367635895, 5381.112116500773, 5390.00284947286, 5411.540019098342, 5418.647787893814, 3242.96757032429, 3366.224587039388, 3460.3944309745693, 3531.4526248431534, 3561.8753343632848, 1106.2975010868076, 1111.1222134513725, 2156.1698745982753, 2228.1533017453426, 2232.3860938242115, 12324.0, 12377.504899804087, 12406.131570790048, 12418.627441176688, 12451.128421010533, 4391.275439552502, 4459.710118842265, 4566.292224705176, 4592.0, 4656.208444564432, 9827.606895724233, 9850.80298394028, 9884.703458896245, 9893.703188904345, 9931.0, 5319.813806516753, 5334.279872217278, 5347.358317001985, 5355.3841308249275, 5367.382750983609, 4386.342048692722, 4696.107739529479, 4863.10032643962, 4910.680805747615, 5023.422306434733, 3698.6856117230336, 3746.119661879456, 3782.6973842092566, 3879.573246942834, 3879.7866117363815, 1165.4580620011736, 1165.6328256599145, 1179.9351035693119, 1191.4340688173222, 1205.4876677412065, 834.9582520874053, 852.8507511185518, 938.1275413865171, 962.8844538655406, 963.7397902566267, 5803.88392232153, 5908.586398952118, 5987.520998320211, 5990.071538911476, 6063.6690201907595, 435.9149965756647, 436.8121707665671, 444.6420631391696, 445.3609070983085, 452.04167165608465, 3938.980305098456, 3968.0675041365257, 3997.360422332471, 4003.5195776507007, 4025.657819085352, 10785.245032847783, 11098.722531936766, 11183.776324473627, 11239.269447486051, 11272.887271127347, 11113.666590002313, 11127.554897804159, 11149.609763658233, 11179.105671546256, 11228.382438965771, 7706.730264440717, 8052.59737013147, 8069.798255043671, 8263.214994575506, 8396.454230475, 5883.558733094949, 5925.140854575976, 6003.0695242237525, 6058.0, 6108.6945652716295, 10107.494625268855, 10107.494625268855, 10111.191104711459, 10157.238207134642, 10294.279400441897, 9827.31208815376, 10158.18734501253, 10204.795904081728, 10339.844902326622, 10440.42577658236, 7057.470689698396, 7517.849643007218, 7668.693252269847, 7692.538447693157, 7849.843003140019, 8558.272546833588, 8589.44168629037, 8590.65637374498, 8597.140285971353, 8606.65573377058, 7225.819354516179, 7490.625468726651, 7567.886481702669, 7611.162772094955, 7641.044869391326, 7449.664765085476, 7555.13115991668, 7628.313451789366, 7785.532868027936, 7913.169117242837, 6896.827579310558, 6964.895526567207, 7013.929860701328, 7027.262137475492, 7034.2965703429245, 5061.0, 5121.41103773056, 5151.5106064923775, 5164.018836421068, 5188.9740551297, 5023.522765337287, 5032.924506132485, 5138.203578445347, 5175.404828444777, 5445.1832225166545], "value": 4580.67200513058, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.89907578188655, 337.40448109087464, 342.1855982761029, 345.877213589176, 349.4967247164082, 5637.548996080314, 5674.716264186794, 5683.261176047118, 5694.515966142878, 5724.9141262880985, 5557.694326812024, 5575.637583557076, 5582.888342233153, 5584.4136365681525, 5636.0136976029235, 4191.1617676464675, 4288.914221715564, 4362.825486980517, 4390.385346051556, 4393.209222339978, 4356.215881141393, 4365.934510982338, 4372.0, 4400.437844565181, 4402.00954785174, 4377.233984052794, 4377.890552736175, 4400.97799511002, 4407.206702793496, 4409.713368631029, 4319.071399649075, 4366.5851744084575, 4384.758838263894, 4388.86833394997, 4399.73601583906, 3849.576546579874, 3863.5897897267578, 3867.1298957734566, 3874.6319099685484, 3875.8643447479485, 5455.18172274158, 5470.56235501159, 5483.862903427446, 5495.477929596682, 5510.283663123809, 4830.420349558076, 4922.286268491084, 4990.476000019982, 5017.641708397047, 5039.168537191359, 5817.243758311435, 5845.7369418376275, 5859.648421094706, 5866.325372582165, 5874.32445268791, 4280.79539037396, 4281.272183728774, 4293.540196333231, 4296.5059018213, 4317.784110794448, 6000.579959402844, 6042.6978651067275, 6093.634381937098, 6099.817005489843, 6109.419605137549, 4279.893002674896, 4304.870853874389, 4305.91388172241, 4312.849050283287, 4313.511838415741, 4349.543297953669, 4357.150355680612, 4361.694681372273, 4372.366006928977, 4378.890527736832, 4807.663463557517, 4958.776855041532, 4966.070018688991, 4990.351254336985, 4998.825041123543, 5838.79564215259, 5847.9415205848245, 5855.765769369177, 5879.970600147058, 5935.436133567304, 1504.1877386211324, 1523.223156190351, 1532.9540113796604, 1546.1650708617221, 1548.3651702801797, 954.4464210757744, 956.2493442647627, 956.6030097509456, 968.2592816495387, 1023.3399457349967, 5594.412586678422, 5680.8863822723315, 5683.630564013409, 5689.0, 5695.323198096888, 5967.313758917693, 5971.954907891101, 5980.8803823924145, 5990.400959903975, 6076.848078798065, 5443.537299329601, 5629.016621190775, 5660.688662123623, 5660.716964151776, 5681.460261275172, 3163.402481746703, 3195.440797860365, 3204.6540453009793, 3214.8392580370887, 3219.82290973994, 5923.644581325048, 6128.1726966858905, 6176.166217560662, 6185.381461853779, 6192.845178870564, 6040.697965101727, 6047.969760151171, 6078.422549857756, 6092.817215483543, 6116.143739876421, 6097.298810636745, 6166.876662466726, 6168.9691551541955, 6172.598781079216, 6187.876242475125, 5716.79991200306, 5856.209411729362, 5867.9413205869105, 5874.265716785402, 5952.494038006818, 5944.702764861826, 5974.133750606225, 5975.342712301556, 6001.039833626599, 6011.669358185167, 5851.21008663825, 6039.516838652985, 6081.665508397081, 6114.57197996136, 6235.594686345373, 4152.4601801765575, 4170.395292682605, 4185.6232939035635, 4189.455370801777, 4194.832206711697, 5996.430339117951, 6011.368806275453, 6034.63792172471, 6043.2748070231855, 6048.879022419439, 5585.832425027255, 5896.410358964069, 5923.822285331447, 5927.31835838884, 5941.792037278675, 5934.9109763354445, 5935.792247271324, 5944.9405505946115, 5991.820245392645, 6023.45788879003, 5252.527272545489, 5849.94150058511, 5886.529077673861, 5904.468597826216, 5942.821715348547, 5908.113782932594, 5958.582899197015, 5972.0, 5991.490723288569, 6003.609765365237, 5830.154627578892, 5879.20630714848, 5939.7624095037445, 5940.5940594059475, 5963.642181469126], "value": 4477.354374368002, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.8168911994802, 835.8495470815253, 841.8711778254303, 851.0808327006833, 878.1525827576387, 15549.222538873053, 16728.079955602436, 16732.83267167328, 16906.66186676267, 16937.3225070997, 14262.928685356559, 14320.42718291267, 14365.78451323231, 14370.353334099964, 14465.566033019026, 797.6051854332113, 800.0519384529351, 803.8432505661399, 803.9437239393245, 804.806846356873, 798.7963069417291, 799.940004499662, 822.8560001999656, 825.6903661127077, 832.7876391520153, 873.9781505462382, 876.2639382918347, 876.4565969099135, 876.4697358098355, 877.2324216310728, 867.9522626255554, 868.5613765048641, 871.1158174452935, 871.376965469689, 872.4285592936604, 635.777477882742, 637.9521535884827, 638.1353266324156, 638.3265654734254, 639.4979940746491, 15374.769378459332, 16043.0, 16092.275847586887, 16114.0, 16143.192840358053, 14461.13233206011, 14480.565583032527, 14492.855071449256, 14954.0, 15442.382304707799, 12622.368881555978, 12933.224006559543, 13271.270080145589, 13860.93069534656, 13966.092204006707, 3922.8430862765454, 3947.9013024674327, 4040.393940908858, 4094.6928980326593, 4098.8360465581345, 83976.58011709963, 85262.16320265603, 85786.14213857843, 85876.57061714651, 86597.56701216454, 10907.127429805596, 11512.827307590393, 11642.24325418862, 12010.699732506582, 12294.385280735927, 21318.14727410917, 21519.78480215178, 21519.892400537898, 21793.67309490359, 21882.78117218839, 8464.915350846535, 8566.571671416405, 8574.699885503978, 8704.260137888225, 8725.825483490295, 5073.2678193805195, 5136.409312928986, 5158.226266060046, 5165.819196328186, 5232.110541208004, 3546.733994950389, 3613.512175856226, 3613.94579081314, 3615.439606860941, 3619.2218672985437, 635.6980434293766, 645.122633218822, 652.2759736692268, 653.3074940563018, 656.9343065693488, 731.6159016516372, 736.6519071540654, 764.3732139645548, 771.7952909588938, 786.1116937860296, 9503.0, 9760.5994243212, 9845.964079838022, 9965.0, 10159.187265018782, 645.7481582182952, 727.2146082231178, 745.1616930952679, 764.58712295361, 803.5941849366033, 4722.716637001791, 4898.338724272249, 4929.630277729185, 4976.730744317213, 5071.290019397287, 114776.26118694199, 116037.41981290039, 118503.40748296375, 118925.0, 121080.0, 102707.4864625672, 104254.0, 105743.0, 106671.0, 106833.46583267034, 82992.58503707443, 88106.55946720226, 88552.0, 89838.0, 94909.5254523723, 9625.0, 9971.800563988534, 10041.246906481896, 10278.640247591298, 10292.433916134385, 51916.740416297675, 51966.0, 52943.0, 54070.0, 54315.45684543104, 67490.0, 77209.0, 78578.2142178571, 80044.79820807102, 81541.18458815335, 12835.294058826854, 12852.0, 13003.479860805463, 13017.21896686202, 13124.40940157676, 15337.769933450783, 15443.536693899201, 15741.606459838596, 15786.289616967035, 16307.347706092098, 14516.927415362856, 14896.654644944658, 15254.466093686668, 15281.46514871974, 15729.44946926852, 14614.634634134232, 14718.0, 15193.924030379778, 15263.847361526243, 15637.452689155825, 13704.3833027516, 13991.23048232357, 14079.366428510946, 14202.218877961812, 14602.12387256768, 11060.944695276472, 11169.664910052712, 11388.772224555629, 12044.457999390224, 12126.636200913987, 11345.262557933707, 12177.573784917486, 12356.567520136752, 12366.752664946831, 12569.0], "value": 7899.539043255445, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 106.0, 112.0, 114.0, 114.0, 114.0, 113.0, 113.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 144.0, 180.0, 122.0, 147.0, 148.0, 119.0, 182.0, 117.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 163.0, 164.0, 170.0, 164.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 75.0, 166.0, 77.0, 76.0, 75.0, 77.0, 167.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 158.0, 84.0, 85.0, 84.0, 147.0, 84.0, 85.0, 143.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 121.0, 120.0, 119.0, 117.0, 118.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 98.0, 100.0, 101.0, 96.0, 96.0, 95.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 51.0, 51.0, 50.0, 56.0, 52.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 78.0, 75.0, 76.0, 76.0, 74.0, 84.0, 81.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 125.0, 120.0, 120.0, 130.0, 123.0, 140.0, 148.0, 140.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 159.0, 157.0, 159.0, 159.0, 157.0, 155.0, 156.0, 160.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 72.0, 68.0, 71.0, 61.0, 66.0, 62.0, 63.0, 63.0], "value": 65.4, "unit": "score"}]}]} 05:53:15 INFO - Return code: 0 05:53:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:15 ERROR - # TBPL SUCCESS # 05:53:15 INFO - Running post-action listener: _resource_record_post_action 05:53:15 INFO - [mozharness: 2016-07-21 12:53:15.912169Z] Finished run-tests step (success) 05:53:15 INFO - Running post-run listener: _resource_record_post_run 05:53:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 559841280; Read time: 472; Write time: 573016 05:53:15 INFO - TinderboxPrint: CPU usage
13.4% 05:53:15 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 472 05:53:15 INFO - TinderboxPrint: I/O write bytes / time
559,841,280 / 573,016 05:53:15 INFO - TinderboxPrint: CPU idle
8,233.5 (86.6%) 05:53:15 INFO - TinderboxPrint: CPU user
1,212.9 (12.8%) 05:53:15 INFO - TinderboxPrint: Swap in / out
0 / 0 05:53:15 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 261095424; Read time: 220; Write time: 330112 05:53:16 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298745856; Read time: 232; Write time: 242904 05:53:16 INFO - Running post-run listener: _upload_blobber_files 05:53:16 INFO - Blob upload gear active. 05:53:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:53:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:17 INFO - (blobuploader) - INFO - Done attempting. 05:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:29 INFO - (blobuploader) - INFO - Done attempting. 05:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:30 INFO - (blobuploader) - INFO - Done attempting. 05:53:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:30 INFO - Return code: 0 05:53:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74728a3bf0beec9295f3687e83dd62e89c92bcd5ea50b4140de1d30d3b6ef3d21411c8617f3c10071748627af8201c48e553b71aa9ad7991dc589477ab40baa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f1f6954aaadb7045f070485b7d868dcf1d9b0b7b743b71c98a5c2fee686728d6266d1941236f7d7197e6fb7b461beb2713bbf8e2be731123585ef5f4c83dbf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fdb73e3ea2847b5cbfe69194daeb6e22527108d1480ef83d856f3784cd014b03016815ba388f9ce975b3eb4e53ec3adbf6ce538e6ec7a7a8f5cc1b332d37147"} 05:53:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:30 INFO - Contents: 05:53:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74728a3bf0beec9295f3687e83dd62e89c92bcd5ea50b4140de1d30d3b6ef3d21411c8617f3c10071748627af8201c48e553b71aa9ad7991dc589477ab40baa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f1f6954aaadb7045f070485b7d868dcf1d9b0b7b743b71c98a5c2fee686728d6266d1941236f7d7197e6fb7b461beb2713bbf8e2be731123585ef5f4c83dbf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fdb73e3ea2847b5cbfe69194daeb6e22527108d1480ef83d856f3784cd014b03016815ba388f9ce975b3eb4e53ec3adbf6ce538e6ec7a7a8f5cc1b332d37147"} 05:53:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:30 INFO - Copying logs to upload dir... 05:53:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.500384 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-21 05:53:30.336054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:53:30.339759) ========= 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=db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74728a3bf0beec9295f3687e83dd62e89c92bcd5ea50b4140de1d30d3b6ef3d21411c8617f3c10071748627af8201c48e553b71aa9ad7991dc589477ab40baa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f1f6954aaadb7045f070485b7d868dcf1d9b0b7b743b71c98a5c2fee686728d6266d1941236f7d7197e6fb7b461beb2713bbf8e2be731123585ef5f4c83dbf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fdb73e3ea2847b5cbfe69194daeb6e22527108d1480ef83d856f3784cd014b03016815ba388f9ce975b3eb4e53ec3adbf6ce538e6ec7a7a8f5cc1b332d37147"} build_url:https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/MtnrICarQECOHARtWcyvOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74728a3bf0beec9295f3687e83dd62e89c92bcd5ea50b4140de1d30d3b6ef3d21411c8617f3c10071748627af8201c48e553b71aa9ad7991dc589477ab40baa3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f1f6954aaadb7045f070485b7d868dcf1d9b0b7b743b71c98a5c2fee686728d6266d1941236f7d7197e6fb7b461beb2713bbf8e2be731123585ef5f4c83dbf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fdb73e3ea2847b5cbfe69194daeb6e22527108d1480ef83d856f3784cd014b03016815ba388f9ce975b3eb4e53ec3adbf6ce538e6ec7a7a8f5cc1b332d37147"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:53:30.365084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:53:30.365422) ========= 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=db0483c52d987ecb441a263b000001ad-1469104367.8041-1883017316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:53:30.519937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:53:30.520248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:53:30.520534) ========= ========= Total master_lag: 0.25 =========