builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1470755271.06 results: success (0) buildid: 20160809053001 builduid: fc41c04d306a491b862d8003a5ffc71a revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.062110) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.062600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.062886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.078123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.078650) ========= 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=232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 08:07:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2016-08-09 08:07:51 (18.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.193928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.194235) ========= 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=232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015755 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.244015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.244377) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --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 a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --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=232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 08:07:51,686 truncating revision to first 12 chars 2016-08-09 08:07:51,686 Setting DEBUG logging. 2016-08-09 08:07:51,687 attempt 1/10 2016-08-09 08:07:51,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3fb4eb11fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 08:07:52,062 unpacking tar archive at: fx-team-a3fb4eb11fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706741 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.964688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.964960) ========= script_repo_revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.965338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.965601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:07:51.974537) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-09 08:07:51.974912) ========= /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=232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:52 INFO - MultiFileLogger online at 20160809 08:07:52 in /builds/slave/test 08:07:52 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 08:07:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:07:52 INFO - {'append_to_log': False, 08:07:52 INFO - 'base_work_dir': '/builds/slave/test', 08:07:52 INFO - 'blob_upload_branch': 'Fx-Team', 08:07:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:07:52 INFO - 'branch': 'Fx-Team', 08:07:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:52 INFO - 'config_files': ('talos/linux_config.py',), 08:07:52 INFO - 'default_actions': ('clobber', 08:07:52 INFO - 'read-buildbot-config', 08:07:52 INFO - 'download-and-extract', 08:07:52 INFO - 'populate-webroot', 08:07:52 INFO - 'create-virtualenv', 08:07:52 INFO - 'install', 08:07:52 INFO - 'run-tests'), 08:07:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:52 INFO - 'download_minidump_stackwalk': True, 08:07:52 INFO - 'download_symbols': 'ondemand', 08:07:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:52 INFO - 'installer_path': 'installer.exe', 08:07:52 INFO - 'log_level': 'info', 08:07:52 INFO - 'log_name': 'talos', 08:07:52 INFO - 'log_to_console': True, 08:07:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:52 INFO - 'opt_config_files': (), 08:07:52 INFO - 'pip_index': False, 08:07:52 INFO - 'sps_profile': False, 08:07:52 INFO - 'sps_profile_interval': 0, 08:07:52 INFO - 'suite': 'dromaeojs-e10s', 08:07:52 INFO - 'system_bits': '32', 08:07:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:52 INFO - 'title': 'talos-linux64-ix-025', 08:07:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:52 INFO - 'use_talos_json': True, 08:07:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:07:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:52 INFO - 'work_dir': 'build'} 08:07:52 INFO - [mozharness: 2016-08-09 15:07:52.506310Z] Running clobber step. 08:07:52 INFO - Running pre-action listener: _resource_record_pre_action 08:07:52 INFO - Running main action method: clobber 08:07:52 INFO - rmtree: /builds/slave/test/build 08:07:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:52 INFO - Running post-action listener: _resource_record_post_action 08:07:52 INFO - [mozharness: 2016-08-09 15:07:52.963533Z] Finished clobber step (success) 08:07:52 INFO - [mozharness: 2016-08-09 15:07:52.963634Z] Running read-buildbot-config step. 08:07:52 INFO - Running pre-action listener: _resource_record_pre_action 08:07:52 INFO - Running main action method: read_buildbot_config 08:07:52 INFO - Using buildbot properties: 08:07:52 INFO - { 08:07:52 INFO - "project": "", 08:07:52 INFO - "product": "firefox", 08:07:52 INFO - "script_repo_revision": "production", 08:07:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:07:52 INFO - "repository": "", 08:07:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:07:52 INFO - "buildid": "20160809053001", 08:07:52 INFO - "pgo_build": "True", 08:07:52 INFO - "basedir": "/builds/slave/test", 08:07:52 INFO - "buildnumber": 685, 08:07:52 INFO - "slavename": "talos-linux64-ix-025", 08:07:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:07:52 INFO - "platform": "ubuntu64_hw", 08:07:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:07:52 INFO - "branch": "fx-team", 08:07:52 INFO - "repo_path": "integration/fx-team", 08:07:52 INFO - "revision": "a3fb4eb11fcf840b9e0d65a06be6cf64584add08", 08:07:52 INFO - "stage_platform": "linux64-pgo", 08:07:52 INFO - "builduid": "fc41c04d306a491b862d8003a5ffc71a", 08:07:52 INFO - "slavebuilddir": "test" 08:07:52 INFO - } 08:07:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:07:52 INFO - Running post-action listener: _resource_record_post_action 08:07:52 INFO - [mozharness: 2016-08-09 15:07:52.966258Z] Finished read-buildbot-config step (success) 08:07:52 INFO - [mozharness: 2016-08-09 15:07:52.966347Z] Running download-and-extract step. 08:07:52 INFO - Running pre-action listener: _resource_record_pre_action 08:07:52 INFO - Running main action method: download_and_extract 08:07:52 INFO - mkdir: /builds/slave/test/build/tests 08:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:52 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:07:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:07:53 INFO - Downloaded 1361 bytes. 08:07:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:07:53 INFO - Using the following test package requirements: 08:07:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'jsshell-linux-x86_64.zip'], 08:07:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:53 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:07:53 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:55 INFO - Downloaded 21829645 bytes. 08:07:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:56 INFO - Return code: 0 08:07:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:56 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:07:56 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:57 INFO - Downloaded 21829645 bytes. 08:07:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:59 INFO - Return code: 0 08:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:59 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:59 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:08:00 INFO - Downloaded 14413723 bytes. 08:08:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:08:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:08:00 INFO - Return code: 0 08:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:00 INFO - trying https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:00 INFO - Downloading https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:08:02 INFO - Downloaded 59951927 bytes. 08:08:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:02 INFO - mkdir: /builds/slave/test/properties 08:08:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:08:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:08:02 INFO - Contents: 08:08:02 INFO - build_url:https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:03 INFO - Running post-action listener: _resource_record_post_action 08:08:03 INFO - Running post-action listener: set_extra_try_arguments 08:08:03 INFO - [mozharness: 2016-08-09 15:08:03.363378Z] Finished download-and-extract step (success) 08:08:03 INFO - [mozharness: 2016-08-09 15:08:03.363612Z] Running populate-webroot step. 08:08:03 INFO - Running pre-action listener: _resource_record_pre_action 08:08:03 INFO - Running main action method: populate_webroot 08:08:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:03 INFO - '--tppagecycles', 08:08:03 INFO - '7'], 08:08:03 INFO - 'tests': ['tsvgm']}}, 08:08:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:08:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:08:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:08:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['damp', 'tps']}, 08:08:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'tests': ['damp', 'tps']}, 08:08:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['dromaeo_dom']}, 08:08:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['basic_compositor_video']}, 08:08:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:08:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['a11yr', 08:08:03 INFO - 'ts_paint', 08:08:03 INFO - 'tpaint', 08:08:03 INFO - 'sessionrestore', 08:08:03 INFO - 'sessionrestore_no_auto_restore', 08:08:03 INFO - 'tabpaint']}, 08:08:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:08:03 INFO - 'ts_paint', 08:08:03 INFO - 'tpaint', 08:08:03 INFO - 'sessionrestore', 08:08:03 INFO - 'sessionrestore_no_auto_restore', 08:08:03 INFO - 'tabpaint']}, 08:08:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:08:03 INFO - 'ts_paint', 08:08:03 INFO - 'tpaint', 08:08:03 INFO - 'sessionrestore', 08:08:03 INFO - 'sessionrestore_no_auto_restore', 08:08:03 INFO - 'tabpaint']}, 08:08:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:08:03 INFO - 'ts_paint', 08:08:03 INFO - 'tpaint', 08:08:03 INFO - 'sessionrestore', 08:08:03 INFO - 'sessionrestore_no_auto_restore', 08:08:03 INFO - 'tabpaint']}, 08:08:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['a11yr', 08:08:03 INFO - 'ts_paint', 08:08:03 INFO - 'tpaint', 08:08:03 INFO - 'sessionrestore', 08:08:03 INFO - 'sessionrestore_no_auto_restore', 08:08:03 INFO - 'tabpaint']}, 08:08:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['a11yr', 08:08:03 INFO - 'ts_paint', 08:08:03 INFO - 'tpaint', 08:08:03 INFO - 'sessionrestore', 08:08:03 INFO - 'sessionrestore_no_auto_restore', 08:08:03 INFO - 'tabpaint']}, 08:08:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['tsvgx', 08:08:03 INFO - 'tsvgr_opacity', 08:08:03 INFO - 'tart', 08:08:03 INFO - 'tscrollx', 08:08:03 INFO - 'cart']}, 08:08:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:08:03 INFO - 'tsvgr_opacity', 08:08:03 INFO - 'tart', 08:08:03 INFO - 'tscrollx', 08:08:03 INFO - 'cart']}, 08:08:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'talos_options': ['--disable-e10s'], 08:08:03 INFO - 'tests': ['tp5o']}, 08:08:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'tests': ['tp5o']}, 08:08:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'talos_options': ['--disable-e10s', 08:08:03 INFO - '--xperf_path', 08:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:03 INFO - 'tests': ['tp5n']}, 08:08:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:03 INFO - 'talos_options': ['--xperf_path', 08:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:03 INFO - 'tests': ['tp5n']}}, 08:08:03 INFO - 'talos.zip': {'path': '', 08:08:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:03 INFO - Running post-action listener: _resource_record_post_action 08:08:03 INFO - [mozharness: 2016-08-09 15:08:03.385721Z] Finished populate-webroot step (success) 08:08:03 INFO - [mozharness: 2016-08-09 15:08:03.385810Z] Running create-virtualenv step. 08:08:03 INFO - Running pre-action listener: _resource_record_pre_action 08:08:03 INFO - Running main action method: create_virtualenv 08:08:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:08:03 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 08:08:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:08:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:03 INFO - Using real prefix '/usr' 08:08:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:08:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:05 INFO - Installing pip.................done. 08:08:05 INFO - Return code: 0 08:08:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08: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 08:08: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 08:08:05 INFO - Using env: {'DISPLAY': ':0', 08:08:05 INFO - 'HOME': '/home/cltbld', 08:08:05 INFO - 'LANG': 'en_US.UTF-8', 08:08:05 INFO - 'LANGUAGE': 'en_US:en', 08:08:05 INFO - 'LOGNAME': 'cltbld', 08:08:05 INFO - 'MAIL': '/var/mail/cltbld', 08:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:05 INFO - 'MOZ_NO_REMOTE': '1', 08:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:05 INFO - 'NO_EM_RESTART': '1', 08:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:05 INFO - 'PWD': '/builds/slave/test', 08:08:05 INFO - 'SHELL': '/bin/bash', 08:08:05 INFO - 'SHLVL': '1', 08:08:05 INFO - 'TERM': 'linux', 08:08:05 INFO - 'TMOUT': '86400', 08:08:05 INFO - 'USER': 'cltbld', 08:08:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:05 INFO - '_': '/tools/buildbot/bin/python'} 08:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:06 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 08:08:06 INFO - Cleaning up... 08:08:06 INFO - Return code: 0 08:08:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:06 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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08:06 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 08:08:06 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 08:08:06 INFO - Using env: {'DISPLAY': ':0', 08:08:06 INFO - 'HOME': '/home/cltbld', 08:08:06 INFO - 'LANG': 'en_US.UTF-8', 08:08:06 INFO - 'LANGUAGE': 'en_US:en', 08:08:06 INFO - 'LOGNAME': 'cltbld', 08:08:06 INFO - 'MAIL': '/var/mail/cltbld', 08:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:06 INFO - 'MOZ_NO_REMOTE': '1', 08:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:06 INFO - 'NO_EM_RESTART': '1', 08:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:06 INFO - 'PWD': '/builds/slave/test', 08:08:06 INFO - 'SHELL': '/bin/bash', 08:08:06 INFO - 'SHLVL': '1', 08:08:06 INFO - 'TERM': 'linux', 08:08:06 INFO - 'TMOUT': '86400', 08:08:06 INFO - 'USER': 'cltbld', 08:08:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:06 INFO - '_': '/tools/buildbot/bin/python'} 08:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:06 INFO - Downloading/unpacking psutil>=3.1.1 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:06 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 08:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:08 INFO - Installing collected packages: psutil 08:08:08 INFO - Running setup.py install for psutil 08:08:08 INFO - building 'psutil._psutil_linux' extension 08:08: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 08:08: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 08:08:08 INFO - building 'psutil._psutil_posix' extension 08:08: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 08:08: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 08:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:08 INFO - Successfully installed psutil 08:08:08 INFO - Cleaning up... 08:08:08 INFO - Return code: 0 08:08:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08: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 08:08: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 08:08:08 INFO - Using env: {'DISPLAY': ':0', 08:08:08 INFO - 'HOME': '/home/cltbld', 08:08:08 INFO - 'LANG': 'en_US.UTF-8', 08:08:08 INFO - 'LANGUAGE': 'en_US:en', 08:08:08 INFO - 'LOGNAME': 'cltbld', 08:08:08 INFO - 'MAIL': '/var/mail/cltbld', 08:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:08 INFO - 'MOZ_NO_REMOTE': '1', 08:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:08 INFO - 'NO_EM_RESTART': '1', 08:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:08 INFO - 'PWD': '/builds/slave/test', 08:08:08 INFO - 'SHELL': '/bin/bash', 08:08:08 INFO - 'SHLVL': '1', 08:08:08 INFO - 'TERM': 'linux', 08:08:08 INFO - 'TMOUT': '86400', 08:08:08 INFO - 'USER': 'cltbld', 08:08:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:08 INFO - '_': '/tools/buildbot/bin/python'} 08:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:09 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 08:08:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:08:11 INFO - Installing collected packages: mozsystemmonitor 08:08:11 INFO - Running setup.py install for mozsystemmonitor 08:08:11 INFO - Successfully installed mozsystemmonitor 08:08:11 INFO - Cleaning up... 08:08:11 INFO - Return code: 0 08:08:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:08:11 INFO - Using env: {'DISPLAY': ':0', 08:08:11 INFO - 'HOME': '/home/cltbld', 08:08:11 INFO - 'LANG': 'en_US.UTF-8', 08:08:11 INFO - 'LANGUAGE': 'en_US:en', 08:08:11 INFO - 'LOGNAME': 'cltbld', 08:08:11 INFO - 'MAIL': '/var/mail/cltbld', 08:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:11 INFO - 'MOZ_NO_REMOTE': '1', 08:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:11 INFO - 'NO_EM_RESTART': '1', 08:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:11 INFO - 'PWD': '/builds/slave/test', 08:08:11 INFO - 'SHELL': '/bin/bash', 08:08:11 INFO - 'SHLVL': '1', 08:08:11 INFO - 'TERM': 'linux', 08:08:11 INFO - 'TMOUT': '86400', 08:08:11 INFO - 'USER': 'cltbld', 08:08:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:11 INFO - '_': '/tools/buildbot/bin/python'} 08:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:13 INFO - warning: no files found matching '*.txt' 08:08:13 INFO - no previously-included directories found matching 'build' 08:08:13 INFO - no previously-included directories found matching 'dist' 08:08:13 INFO - no previously-included directories found matching '.git*' 08:08:13 INFO - Installing collected packages: jsonschema, functools32 08:08:13 INFO - Running setup.py install for functools32 08:08:13 INFO - warning: no files found matching '*.txt' 08:08:13 INFO - no previously-included directories found matching 'build' 08:08:13 INFO - no previously-included directories found matching 'dist' 08:08:13 INFO - no previously-included directories found matching '.git*' 08:08:13 INFO - Successfully installed jsonschema functools32 08:08:13 INFO - Cleaning up... 08:08:13 INFO - Return code: 0 08:08:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:08: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 functools32==3.2.3-2 08:08:13 INFO - Using env: {'DISPLAY': ':0', 08:08:13 INFO - 'HOME': '/home/cltbld', 08:08:13 INFO - 'LANG': 'en_US.UTF-8', 08:08:13 INFO - 'LANGUAGE': 'en_US:en', 08:08:13 INFO - 'LOGNAME': 'cltbld', 08:08:13 INFO - 'MAIL': '/var/mail/cltbld', 08:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:13 INFO - 'MOZ_NO_REMOTE': '1', 08:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:13 INFO - 'NO_EM_RESTART': '1', 08:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:13 INFO - 'PWD': '/builds/slave/test', 08:08:13 INFO - 'SHELL': '/bin/bash', 08:08:13 INFO - 'SHLVL': '1', 08:08:13 INFO - 'TERM': 'linux', 08:08:13 INFO - 'TMOUT': '86400', 08:08:13 INFO - 'USER': 'cltbld', 08:08:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:13 INFO - '_': '/tools/buildbot/bin/python'} 08:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:08:14 INFO - Cleaning up... 08:08:14 INFO - Return code: 0 08:08:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:08:14 INFO - Using env: {'DISPLAY': ':0', 08:08:14 INFO - 'HOME': '/home/cltbld', 08:08:14 INFO - 'LANG': 'en_US.UTF-8', 08:08:14 INFO - 'LANGUAGE': 'en_US:en', 08:08:14 INFO - 'LOGNAME': 'cltbld', 08:08:14 INFO - 'MAIL': '/var/mail/cltbld', 08:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:14 INFO - 'MOZ_NO_REMOTE': '1', 08:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:14 INFO - 'NO_EM_RESTART': '1', 08:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:14 INFO - 'PWD': '/builds/slave/test', 08:08:14 INFO - 'SHELL': '/bin/bash', 08:08:14 INFO - 'SHLVL': '1', 08:08:14 INFO - 'TERM': 'linux', 08:08:14 INFO - 'TMOUT': '86400', 08:08:14 INFO - 'USER': 'cltbld', 08:08:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:14 INFO - '_': '/tools/buildbot/bin/python'} 08:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:16 INFO - Downloading docopt-0.6.1.tar.gz 08:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:16 INFO - Running setup.py install for blobuploader 08:08:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:17 INFO - Running setup.py install for requests 08:08:17 INFO - Running setup.py install for docopt 08:08:17 INFO - Successfully installed blobuploader requests docopt 08:08:17 INFO - Cleaning up... 08:08:17 INFO - Return code: 0 08:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:17 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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08:17 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 08:08:17 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 08:08:17 INFO - Using env: {'DISPLAY': ':0', 08:08:17 INFO - 'HOME': '/home/cltbld', 08:08:17 INFO - 'LANG': 'en_US.UTF-8', 08:08:17 INFO - 'LANGUAGE': 'en_US:en', 08:08:17 INFO - 'LOGNAME': 'cltbld', 08:08:17 INFO - 'MAIL': '/var/mail/cltbld', 08:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:17 INFO - 'MOZ_NO_REMOTE': '1', 08:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:17 INFO - 'NO_EM_RESTART': '1', 08:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:17 INFO - 'PWD': '/builds/slave/test', 08:08:17 INFO - 'SHELL': '/bin/bash', 08:08:17 INFO - 'SHLVL': '1', 08:08:17 INFO - 'TERM': 'linux', 08:08:17 INFO - 'TMOUT': '86400', 08:08:17 INFO - 'USER': 'cltbld', 08:08:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:17 INFO - '_': '/tools/buildbot/bin/python'} 08:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:17 INFO - Running setup.py (path:/tmp/pip-w2V4NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:17 INFO - Running setup.py (path:/tmp/pip-XBranD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:17 INFO - Running setup.py (path:/tmp/pip-B2RCI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:17 INFO - Running setup.py (path:/tmp/pip-B5y70j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:18 INFO - Running setup.py (path:/tmp/pip-HYNjKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:18 INFO - Running setup.py (path:/tmp/pip-O6DK5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:18 INFO - Running setup.py (path:/tmp/pip-tIC6lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:18 INFO - Running setup.py (path:/tmp/pip-S11Rto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:18 INFO - Running setup.py (path:/tmp/pip-3yPrhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:18 INFO - Running setup.py (path:/tmp/pip-es27Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:18 INFO - Running setup.py (path:/tmp/pip-zmxCVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:18 INFO - Running setup.py (path:/tmp/pip-kZZPYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:18 INFO - Running setup.py (path:/tmp/pip-mJ2huw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:18 INFO - Running setup.py (path:/tmp/pip-C8YTW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:18 INFO - Running setup.py (path:/tmp/pip-1tdUkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:18 INFO - Running setup.py (path:/tmp/pip-4G9lDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:18 INFO - Running setup.py (path:/tmp/pip-UEN9dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:18 INFO - Running setup.py install for manifestparser 08:08:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Running setup.py install for mozcrash 08:08:19 INFO - Running setup.py install for mozdebug 08:08:19 INFO - Running setup.py install for mozdevice 08:08:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Running setup.py install for mozfile 08:08:19 INFO - Running setup.py install for mozhttpd 08:08:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Running setup.py install for mozinfo 08:08:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Running setup.py install for mozInstall 08:08:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:19 INFO - Running setup.py install for mozleak 08:08:19 INFO - Running setup.py install for mozlog 08:08:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Running setup.py install for moznetwork 08:08:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Running setup.py install for mozprocess 08:08:20 INFO - Running setup.py install for mozprofile 08:08:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Running setup.py install for mozrunner 08:08:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Running setup.py install for mozscreenshot 08:08:20 INFO - Running setup.py install for moztest 08:08:20 INFO - Running setup.py install for mozversion 08:08:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:20 INFO - Cleaning up... 08:08:20 INFO - Return code: 0 08:08:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08: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 08:08: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 08:08:20 INFO - Using env: {'DISPLAY': ':0', 08:08:20 INFO - 'HOME': '/home/cltbld', 08:08:20 INFO - 'LANG': 'en_US.UTF-8', 08:08:20 INFO - 'LANGUAGE': 'en_US:en', 08:08:20 INFO - 'LOGNAME': 'cltbld', 08:08:20 INFO - 'MAIL': '/var/mail/cltbld', 08:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:20 INFO - 'MOZ_NO_REMOTE': '1', 08:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:20 INFO - 'NO_EM_RESTART': '1', 08:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:20 INFO - 'PWD': '/builds/slave/test', 08:08:20 INFO - 'SHELL': '/bin/bash', 08:08:20 INFO - 'SHLVL': '1', 08:08:20 INFO - 'TERM': 'linux', 08:08:20 INFO - 'TMOUT': '86400', 08:08:20 INFO - 'USER': 'cltbld', 08:08:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:20 INFO - '_': '/tools/buildbot/bin/python'} 08:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:20 INFO - Running setup.py (path:/tmp/pip-dYCd87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:21 INFO - Running setup.py (path:/tmp/pip-Rh4uJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:21 INFO - Running setup.py (path:/tmp/pip-Tv0qHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:21 INFO - Running setup.py (path:/tmp/pip-k73NZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:21 INFO - Running setup.py (path:/tmp/pip-Yo_p1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:21 INFO - Running setup.py (path:/tmp/pip-jxnKAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:21 INFO - Running setup.py (path:/tmp/pip-aMvIjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:21 INFO - Running setup.py (path:/tmp/pip-zRCZtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:21 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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:21 INFO - Running setup.py (path:/tmp/pip-4jxXiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08: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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:21 INFO - Running setup.py (path:/tmp/pip-dnioRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08: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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:21 INFO - Running setup.py (path:/tmp/pip-HzDOpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08: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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:21 INFO - Running setup.py (path:/tmp/pip-dDpkC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08: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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:21 INFO - Running setup.py (path:/tmp/pip-IBnuVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08: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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:21 INFO - Running setup.py (path:/tmp/pip-xNeJT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08: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)) 08:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:21 INFO - Running setup.py (path:/tmp/pip-ZPMh_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:22 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)) 08:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:22 INFO - Running setup.py (path:/tmp/pip-qGBEho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:22 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)) 08:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:22 INFO - Running setup.py (path:/tmp/pip-mVQCII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 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)) 08:08:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:22 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 08:08:22 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 08:08:22 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 08:08:22 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 08:08:22 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 08:08:22 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 08:08:24 INFO - Downloading blessings-1.6.tar.gz 08:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:24 INFO - Installing collected packages: blessings 08:08:24 INFO - Running setup.py install for blessings 08:08:24 INFO - Successfully installed blessings 08:08:24 INFO - Cleaning up... 08:08:24 INFO - Return code: 0 08:08:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:24 INFO - Reading from file tmpfile_stdout 08:08:24 INFO - Current package versions: 08:08:24 INFO - argparse == 1.2.1 08:08:24 INFO - blessings == 1.6 08:08:24 INFO - blobuploader == 1.2.4 08:08:24 INFO - docopt == 0.6.1 08:08:24 INFO - functools32 == 3.2.3-2 08:08:24 INFO - jsonschema == 2.5.1 08:08:24 INFO - manifestparser == 1.1 08:08:24 INFO - mozInstall == 1.12 08:08:24 INFO - mozcrash == 0.17 08:08:24 INFO - mozdebug == 0.1 08:08:24 INFO - mozdevice == 0.48 08:08:24 INFO - mozfile == 1.2 08:08:24 INFO - mozhttpd == 0.7 08:08:24 INFO - mozinfo == 0.9 08:08:24 INFO - mozleak == 0.1 08:08:24 INFO - mozlog == 3.3 08:08:24 INFO - moznetwork == 0.27 08:08:24 INFO - mozprocess == 0.23 08:08:24 INFO - mozprofile == 0.28 08:08:24 INFO - mozrunner == 6.12 08:08:24 INFO - mozscreenshot == 0.1 08:08:24 INFO - mozsystemmonitor == 0.3 08:08:24 INFO - moztest == 0.7 08:08:24 INFO - mozversion == 1.4 08:08:24 INFO - psutil == 3.1.1 08:08:24 INFO - requests == 1.2.3 08:08:24 INFO - wsgiref == 0.1.2 08:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08: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 08:08: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 08:08:24 INFO - Using env: {'DISPLAY': ':0', 08:08:24 INFO - 'HOME': '/home/cltbld', 08:08:24 INFO - 'LANG': 'en_US.UTF-8', 08:08:24 INFO - 'LANGUAGE': 'en_US:en', 08:08:24 INFO - 'LOGNAME': 'cltbld', 08:08:24 INFO - 'MAIL': '/var/mail/cltbld', 08:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:24 INFO - 'MOZ_NO_REMOTE': '1', 08:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:24 INFO - 'NO_EM_RESTART': '1', 08:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:24 INFO - 'PWD': '/builds/slave/test', 08:08:24 INFO - 'SHELL': '/bin/bash', 08:08:24 INFO - 'SHLVL': '1', 08:08:24 INFO - 'TERM': 'linux', 08:08:24 INFO - 'TMOUT': '86400', 08:08:24 INFO - 'USER': 'cltbld', 08:08:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:24 INFO - '_': '/tools/buildbot/bin/python'} 08:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08: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)) 08:08:24 INFO - Cleaning up... 08:08:24 INFO - Return code: 0 08:08:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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 0x27b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a72180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, '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': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', '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 08:08: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 08:08: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 08:08:24 INFO - Using env: {'DISPLAY': ':0', 08:08:24 INFO - 'HOME': '/home/cltbld', 08:08:24 INFO - 'LANG': 'en_US.UTF-8', 08:08:24 INFO - 'LANGUAGE': 'en_US:en', 08:08:24 INFO - 'LOGNAME': 'cltbld', 08:08:24 INFO - 'MAIL': '/var/mail/cltbld', 08:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:24 INFO - 'MOZ_NO_REMOTE': '1', 08:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:24 INFO - 'NO_EM_RESTART': '1', 08:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:24 INFO - 'PWD': '/builds/slave/test', 08:08:24 INFO - 'SHELL': '/bin/bash', 08:08:24 INFO - 'SHLVL': '1', 08:08:24 INFO - 'TERM': 'linux', 08:08:24 INFO - 'TMOUT': '86400', 08:08:24 INFO - 'USER': 'cltbld', 08:08:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:24 INFO - '_': '/tools/buildbot/bin/python'} 08:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:08:24 INFO - Cleaning up... 08:08:24 INFO - Return code: 0 08:08:24 INFO - Running post-action listener: _resource_record_post_action 08:08:24 INFO - Running post-action listener: _start_resource_monitoring 08:08:25 INFO - Starting resource monitoring. 08:08:25 INFO - [mozharness: 2016-08-09 15:08:25.029034Z] Finished create-virtualenv step (success) 08:08:25 INFO - [mozharness: 2016-08-09 15:08:25.029534Z] Running install step. 08:08:25 INFO - Running pre-action listener: _resource_record_pre_action 08:08:25 INFO - Running main action method: install 08:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:25 INFO - Reading from file tmpfile_stdout 08:08:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:25 INFO - Reading from file tmpfile_stdout 08:08:25 INFO - Output received: 08:08:25 INFO - Usage: mozinstall [options] installer 08:08:25 INFO - Options: 08:08:25 INFO - -h, --help show this help message and exit 08:08:25 INFO - -d DEST, --destination=DEST 08:08:25 INFO - Directory to install application into. [default: 08:08:25 INFO - "/builds/slave/test"] 08:08:25 INFO - --app=APP Application being installed. [default: firefox] 08:08:25 INFO - mkdir: /builds/slave/test/build/application 08:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:42 INFO - Reading from file tmpfile_stdout 08:08:42 INFO - Output received: 08:08:42 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:42 INFO - Running post-action listener: _resource_record_post_action 08:08:42 INFO - [mozharness: 2016-08-09 15:08:42.378290Z] Finished install step (success) 08:08:42 INFO - [mozharness: 2016-08-09 15:08:42.378542Z] Running run-tests step. 08:08:42 INFO - Running pre-action listener: _resource_record_pre_action 08:08:42 INFO - Running main action method: run_tests 08:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:42 INFO - Python 2.7.3 08:08:42 INFO - Return code: 0 08:08:42 INFO - grabbing minidump binary from tooltool 08:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:08: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 0x2a703b0>, '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 0x2a712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a71740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08: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 08:08: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 08:08: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 08:08:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:42 INFO - Return code: 0 08:08:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08: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/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 08:08: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/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 08:08:42 INFO - Using env: {'DISPLAY': ':0', 08:08:42 INFO - 'HOME': '/home/cltbld', 08:08:42 INFO - 'LANG': 'en_US.UTF-8', 08:08:42 INFO - 'LANGUAGE': 'en_US:en', 08:08:42 INFO - 'LOGNAME': 'cltbld', 08:08:42 INFO - 'MAIL': '/var/mail/cltbld', 08:08:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:42 INFO - 'MOZ_NO_REMOTE': '1', 08:08:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:42 INFO - 'NO_EM_RESTART': '1', 08:08:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:42 INFO - 'PWD': '/builds/slave/test', 08:08:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:42 INFO - 'SHELL': '/bin/bash', 08:08:42 INFO - 'SHLVL': '1', 08:08:42 INFO - 'TERM': 'linux', 08:08:42 INFO - 'TMOUT': '86400', 08:08:42 INFO - 'USER': 'cltbld', 08:08:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321', 08:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:42 INFO - '_': '/tools/buildbot/bin/python'} 08:08: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/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 08:08:42 INFO - mozversion application_buildid: 20160809053001 08:08:42 INFO - mozversion application_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 08:08:42 INFO - mozversion application_display_name: Nightly 08:08:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:42 INFO - mozversion application_name: Firefox 08:08:42 INFO - mozversion application_remotingname: firefox 08:08:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:42 INFO - mozversion application_vendor: Mozilla 08:08:42 INFO - mozversion application_version: 51.0a1 08:08:42 INFO - mozversion platform_buildid: 20160809053001 08:08:42 INFO - mozversion platform_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 08:08:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:42 INFO - mozversion platform_version: 51.0a1 08:08:42 INFO - using testdate: 1470755322 08:08:42 INFO - actual date: 1470755322 08:08:42 INFO - starting webserver on 'localhost:39420' 08:08:42 INFO - SUITE-START | Running 2 tests 08:08:42 INFO - TEST-START | dromaeo_css 08:08:42 INFO - operating with platform_type : linux_ 08:08:42 INFO - Initialising browser for dromaeo_css test... 08:08:42 INFO - TEST-INFO | started process 6857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxieY9G/profile http://localhost:39420/getInfo.html) 08:08:47 INFO - PROCESS | 6857 | __metrics Screen width/height:1600/1200 08:08:47 INFO - PROCESS | 6857 | colorDepth:24 08:08:47 INFO - PROCESS | 6857 | Browser inner width/height: 1024/697 08:08:47 INFO - PROCESS | 6857 | __metrics 08:08:47 ERROR - PROCESS | 6857 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:08:48 INFO - TEST-INFO | 6857: exit 0 08:08:48 INFO - Browser initialized. 08:08:48 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:48 INFO - TEST-INFO | started process 6980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxieY9G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:00 INFO - PROCESS | 6980 | RSS: Main: 164376576 08:09:00 INFO - PROCESS | 6980 | 08:09:50 INFO - PROCESS | 6980 | 1470755390176 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] 08:12:00 INFO - PROCESS | 6980 | Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39420/tests/dromaeo/cssquery-ext.html) 08:12:01 INFO - PROCESS | 6980 | RSS: Main: 166883328 08:12:01 INFO - PROCESS | 6980 | 08:15:03 INFO - PROCESS | 6980 | Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-ext.html (next: http://localhost:39420/tests/dromaeo/cssquery-jquery.html) 08:15:04 INFO - PROCESS | 6980 | RSS: Main: 167018496 08:15:04 INFO - PROCESS | 6980 | 08:18:06 INFO - PROCESS | 6980 | Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39420/tests/dromaeo/cssquery-mootools.html) 08:18:06 INFO - PROCESS | 6980 | RSS: Main: 170053632 08:18:06 INFO - PROCESS | 6980 | 08:21:08 INFO - PROCESS | 6980 | Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39420/tests/dromaeo/cssquery-prototype.html) 08:21:09 INFO - PROCESS | 6980 | RSS: Main: 164683776 08:21:09 INFO - PROCESS | 6980 | 08:24:11 INFO - PROCESS | 6980 | Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39420/tests/dromaeo/cssquery-yui.html) 08:24:12 INFO - PROCESS | 6980 | RSS: Main: 167055360 08:24:12 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-yui.html (next: http://localhost:39420/tests/dromaeo/cssquery-dojo.html) 08:27:15 INFO - PROCESS | 6980 | RSS: Main: 170323968 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | __start_tp_report 08:27:15 INFO - PROCESS | 6980 | _x_x_mozilla_page_load 08:27:15 INFO - PROCESS | 6980 | _x_x_mozilla_page_load_details 08:27:15 INFO - PROCESS | 6980 | |i|pagename|runs| 08:27:15 INFO - PROCESS | 6980 | |0;dojo.html;3148.2758965437947;3172.682731726826;3180.1572583265424;3191.505316675916;3201.151694800878;5476.17857321402;5519.668819870805;5523.889522209553;5579.553635709143;5608.971955140229;5456.127019676853;5500.697461639608;5522.420145884685;5536.889262214753;5551.694656793875;4917.50824917509;4999.125153098212;5003.024410240005;5022.246663000561;5036.320096786942;5047.343845300106;5057.216131499605;5116.053530096944;5143.485651434864;5157.432682404932;5034.723090230036;5041.319421878073;5100.77046532905;5116.846494605149;5126.692398456086;4909.656324057281;4966.379202599675;4976.42771081323;5017;5082.822101226477;4971.229459433794;4982.77577509013;4985.351904252424;4996.225585034325;5016.623753218487;5330.973345133289;5397.163439666858;5464.207689884945;5470.753816078286;5477.643953143033;5736.684482353469;5820.505257053155;5829.067349224146;5870.853228669317;5877.85305367365;5894.616849904743;5905.379935106838;5908.438698323653;5912.231409916726;5915.645061296336;5327.786888524493;5523.834284971457;5524.696141712164;5529.751161197756;5535.916961245584;5867.70661466925;5903.852403689856;5951.077582974646;6021.42796434338;6031.577789554777;5720.771169153188;5727.627704199213;5741.569382296345;5744.913826292609;5745.195672605839;5775.104858746901;5813.88372232553;5817.069268917037;5825.300963884361;5835.153902684087;5714.257146570919;5741.483266505951;5838.737256823453;5845.1232315153065;5894.705264736746;5875.265591801025;5882.23530940975;5885.823425297248;5895.587308888336;5908.704564771744;4498.797554110073;4501.639868810487;4503.189425903303;4504.774761261924;4544.0457503924545;3910.432987216838;3947.703922205789;3972;4016.9397459038137;4053.047533829548;5615.989121958087;5622.32532096151;5655.066913959151;5662.320521537359;5677.716114194273;5946.286445626552;5953.047512397996;5960.135780311917;5991.400859914061;5996.970015149896;5434;5543.501084902297;5639.548836093103;5652.152177173457;5734.483896449339;5069.239614057921;5085.720285384339;5085.8728531787;5086.364204474441;5124.538791508782;6159.19930409044;6192.256929168529;6202.906956395657;6218.2538095427935;6219.844503887439;5742.971285143548;5765.711714414347;5848.795292164754;5880.26496687914;5968.970155149196;6065.909011364744;6094.116353128683;6112.235970503687;6117.694115294306;6124.510039196943;5778.797742079007;5784.913226301524;5792.9710351447975;5795.304563452412;5808.419158084327;5749;5849.210356601804;5954.612950158225;5969.04495280753;5991.3409524953095;5785.797497087582;5799.072148456226;5819.76720931158;5844.47399734026;5845.941540584709;5525.310718231051;5761.711914404347;5810.73851676684;5811.738471768866;5812.157237200667;5584.246126772834;5682.687452190004;5685.260916080883;5692.573057020657;5790.305163380422;5813.854653633693;5831.562632802472;5839.839259473852;5844.883102337844;5884.293884733859;5499.752511137089;5705.201271821865;5743.827685169452;5745.712714364181;5746.281714785652 08:27:15 INFO - PROCESS | 6980 | |1;ext.html;552.3674224722881;577.5899111630742;584.3105135939595;600.5375860587346;618.3692633513818;39653.405198922;43389.78305108478;43425.34861977073;43437.56562434375;43554.78222608891;43153.78423107888;44007.339889901596;44036.559634403646;44082;44084;8818.647254109828;8942.19520243178;8953.05992870749;8958.820823583525;8973.685920992766;8824.514651694155;8860.955695221515;8912.376133670645;8931.24084452819;8933.196012358887;8961.731148065568;8975.820483590323;9030.187283144516;9031;9047.638094476213;8924.955375223148;8953.686620968267;8967.327450441211;8991.100889911022;9001.279897608176;8857.557122143931;8944.821103577957;8947.150020748019;8960.596773145224;8964.775880602972;41583;41812.581874181174;41820.58179418197;41966.16067678629;42030.159396812196;3475.3679582955715;3616.584092829332;3877.5346958364894;4089.6319331260033;4161.126163505667;32922.83538582316;33765.155871103176;33888.32223355544;33919.32161356784;34023;4305.495563929563;4456.910861782779;4474.507804141542;4475.977620111878;4532.5240849710635;345267;353034;354579;355522;358171;57802.7109864448;57937.71031144902;58171.418285817446;58265.70867145637;58398;37034.629653703654;37800.81099594484;37807.81096094502;39627.60372396239;39650.801745991084;15531;15661.765073523906;15665.921670391575;15682.372705091668;15750.133742644264;12067.87932120685;12094.576689815814;12109.333986630643;12122;12189.451474683661;19368.28010711841;19473.51316217106;19571.608567828847;19587.319677293424;19609.509762256057;7228.566286022856;7255.8911616325795;7329.670164842595;7332.376747976375;7405.407567394704;949.3591825517748;1084.5986984815668;1086.7283179205199;1128.2948157401624;1136.8408422820812;32798.08643847804;33255.66744332574;33283.500747488804;33337.83331083329;33509.49735753966;1114.8383484394717;1125.178619607691;1133.6825688807148;1161.7095726068483;1202.3447221264432;17247.482575522754;17321.56696082583;17452.65094698099;17453;17552.473425797245;647815;653599;654150;654206;656205;60836.69581652152;61130;61314;61319.6934015336;61400.692996535625;1308.8167656528094;1348.9545602158405;1361.4758318047623;1361.598328493097;1376.9655758605916;30421.695783041887;32414.675853241166;33118.5032224512;33160;33296.500552492216;52157.7392113037;52238.99999999848;52357;52440.47559524356;52453.73773131263;488747;493706;493749;494306;494756;29244.561331579618;29299.85350073236;29835.70164298329;29845;29983.70016299809;48694.75652621714;49164.26253606127;49449.25826112539;49678.503214968834;49761.25358119704;41717.58282417258;42272.365914510694;42401.15197696091;42883;43479;41561.58438415698;42145.36781948212;42391;42718;43257;41940.74177774672;42779.57220427756;43180.352294716235;43410.131797364505;43474.782626086664;35281.11797204988;36614.63385366219;37282;37707.62292377151;38339.2332153361;28541.429171416872;28838.42323153567;29128.7087129126;29160.854195728887;29330 08:27:15 INFO - PROCESS | 6980 | |2;jquery.html;374.7208329794304;383.8061778801705;397.7911596411884;402.27590337392684;415.0391842883724;13615.387307571158;18280;18414.079296035212;19898.502537436572;19944.00279986;18632.161552730126;18679.81320186798;19202.23191072359;19275.807241927578;19498.415047548562;1557.7429724095512;1559.0723519505875;1562.4375224919077;1598.856102950734;5680.659160450376;5654.264945557093;5688.857778555528;5757.827265182052;5770.365259821417;5796.855078623026;5677.148427735831;5680.346760122577;5746.9712651436685;5752.309722833266;5762.308522977228;5611.2144299798065;5669.121286200645;5695.174199741055;5737.13942908565;5773.191753154561;5061.924071138936;5082.23766435034;5089.338386009795;5118.897622047575;5137.948620513785;22427;23045.19341823045;23318.417039574146;23367.649485257563;23520.64719029216;2460.729319774823;2489.55188066148;2886.480433521965;2903.3177203357195;3160.067780004904;9904;10518.526666300035;14757.465476843248;14936.477223297132;15048.849511504965;1966.5476940303668;1977.6143651987868;1981.0986001369486;2017.5157962088992;2033.9389818305474;84421;85116;85667.57166214191;86243;86628.56685716595;10800.51397687106;10899.83650245247;10963.56145754177;11125.554977800797;11133.832992505118;15163.393464261526;15285.159316237714;15304.540863774104;15332.080075195525;15350.846491535165;7798.1811909749795;7890.723824666109;8065.314448271963;8080.9191908080165;8199.42604017713;7184.065396800613;7391.334779869838;7415.555066696015;7511.525919262397;7557.924420755722;4576.519465456079;4665.906681866411;4736.265878788793;4768.666193366431;4826.58973987208;1950.8049195080662;1975.4863735428605;1982.9039368821989;1990.999045958802;2067.824234940017;927.2628260532757;976.8437050071955;992.1417973453056;1000.4997501249376;1011.2415688233824;19399.90300048491;19503.219871204994;19551;19568.804311956697;19724.603273772336;975.5219942228257;1007.6473234368059;1015.1878497202209;1017.1557607186018;1023.3194925374543;10386.584536618602;10783.13734901206;10791.082757965503;10822.458877056273;10841.728956776144;467548;475410;475566;480405;484089;90101.09898901058;91787;91962.54018729864;94356.33861968304;94420.52789736008;963.6482683820356;991.2417000994245;992.7865508915473;1009.1724785675675;1009.4649835587151;16684.749728754323;16832.57918552046;17362.218700158777;17834.37579684705;18103.909480452512;42769.144617108104;42805.78597106995;43442.34836477392;43613;44158.77920610376;55348.72325638346;56678.716606418355;57091;58787.70606146942;60624;7487.962560187382;7871.685132594861;8415;8472.872906906277;8693.956530217309;12851.550195743104;13423.865761342262;13583.932080339535;13616;13746.175229486264;11639.185257031926;11998.220115692453;12053.758924821279;12079.818802717791;12364.62906112818;11536.94231528837;11696.47365868555;11713.941430292794;11893.524259029542;12023.27860328383;11793.174477786815;11841.28952262867;11879.406029698308;11979.281243125091;12269.447874845475;7925.881111783213;7943.6822527100585;7995.2804247618;8183.5499047550575;8207.71273005442;11374;11545.960863522323;11573.826392604286;11883.881161188277;12048.337341445955 08:27:15 INFO - PROCESS | 6980 | |3;mootools.html;1478.593386818625;1505.2248092232503;1598.2328482328483;1700.8469237768597;1734.9132543372828;8058.5567793771315;8520.531370774605;8643.394962352639;9337.953310233448;9354.672586459466;8599.140085991397;8767.56162191891;8996.100389961;8999.685011024616;9013.729588112366;2446.217210492643;2469.061756532515;2492.476579918219;2493.650888875559;2495.800335973118;2390.784829365357;2490.3525083478244;2494.0397946790526;2503.4617557225192;2508.385445565839;2438.634204869275;2442.9511409771794;2488.4774197418565;2489.3029951613485;2493.0401795308753;2382.5592265430864;2388.868612226327;2398.028798336668;2416.1422694943394;2416.516696660675;2187.332863476639;2211.5576884623138;2217.1020736601704;2222.0667319725753;2228.253535065755;8910.108989101038;8931.37480376374;8996.415233009833;9098.954505227432;9102.453852768855;5420.566354691615;5464.562834973192;5527.447255274481;5543.667379957215;5544.390117087117;3536.7877927324444;3603.621619729917;3625.963740362589;3692.593814680383;3723.9069023274365;1247.7379750252458;1256.3655354046148;1261.564760157744;1275.609585551753;1277.3485522383558;12523.436445359981;12653.746925061447;12689;12723.427445764963;12728.854403103673;4670.660433920052;4761.571458568746;4815.638827087912;4924.532169443897;4925.532074452921;10597.735056623493;10613.248813945767;10621.468926553796;10646;10652.840207396895;5477.917831232535;5502;5535;5541.501264886179;5567.888642227133;4357.281048626941;4829.879253018703;4957.479464656231;4972.204447288416;5101.464346243591;4078.8592490479637;4141.316682747313;4171.205451515866;4192.287311157111;4223.640990515779;1322.8875545578733;1334.813126162338;1360.7006458579096;1367.5145323410245;1383.8201033865735;873.6461732998146;947.7441090905417;970.0687340153531;971.3491960386558;977.8875429325576;5774.94225057744;5868.090445980794;6031.7587296507645;6275.843103922439;6325.493960483151;438.41033809526135;438.9890252743643;442.46019855775904;453.4445304501959;460.62459095836783;4185.518665353523;4243.193793179286;4243.533211346749;4287.442632457823;4295.334223195409;11003.22977391591;11390.430478476042;11393.886061139448;11394.601188958346;11399.943000285111;11346.48940797666;11366.488508017159;11368.204225704287;11372.31766094037;11422.14333924959;7999.84000320002;8260.958695206486;8268.049174345027;8533.786655333666;8541.871871921927;5972.611780234271;6068.362821903636;6141.07883817431;6149.938500614937;6208.255009398901;10171.389716617026;10531.684049478528;10659;10704.839427408438;10751.139908807432;10418.947905260426;10433.373997560171;10570.947145264532;10591.4704264788;10618.681439556825;7229.710811567478;7704.576248306173;7738.148803631483;7863.292303692695;7867.17394673551;8641.308695304235;8717.694880679146;8764.035956044703;8774.29805615562;8779;7637.121731000784;7850.685972561034;7907.367410607253;7987.760367188994;8077.717279895411;7803.102643196105;7892.960535197517;7932.444728868923;8012.559309238048;8067.435279530377;7136.964315178391;7188.856222875618;7235.312645298688;7242.565446073252;7283.890741638986;4946.08497427977;4950.8762280943265;4993.850184494471;5002.349694539832;5092.745362731775;5108.361454818148;5156.432792392909;5189.415667007416;5266.868328291824;5348.171033489815 08:27:15 INFO - PROCESS | 6980 | |4;prototype.html;332.1844870842081;338.9576302962129;347.0802373709669;348.19566800690404;348.6861824358076;5443.1835224716315;5530.861728456781;5544.695041772701;5579;5593.216949627051;5418.566514678826;5428.240046393508;5439.0209762242785;5473.17902314653;5493.697846618435;4252.489701235856;4268.317069268917;4296.462942132233;4330.545292744264;4388.648908087353;4320.546342634026;4326.935095973563;4327.697061205717;4347.586979236968;4373.846915357964;4289;4312.22379971605;4313.460817397825;4324.113556720865;4324.675649326297;4092.897677558055;4210.410542524049;4236.279832428495;4243.490781106287;4277.422547956017;3752.212035472554;3755.0800053986677;3756.3284338469393;3768.152165762709;3772.641599048086;5393.083175860113;5398.91901621476;5407.297051383334;5416.350037995427;5419.132938729824;4624.5375462453485;4833.202521583935;4876.097921884428;4877.268409738532;4899.779509922062;5702.572307076985;5724;5731.856703582402;5755.453231942959;5757.596968212227;4114.136031433402;4120.134771697947;4141.399497072907;4161.271777438936;4162.646175075122;5855.4144585541535;5898.233229680157;5902.203202567642;5911.970440147815;5940.940590594082;4206.642435392964;4209.326507758805;4212.4523811904255;4220.155968806251;4230.809613567335;4251.553586873396;4274.508431530352;4280.186764514732;4282;4294.549072347359;4655.464621568563;4807.855764327076;4835;4866.732329721899;4885.95114048855;5726.914096288559;5730.739237367772;5735.369109397963;5789.9710501447225;5800.129980502874;1440.5030264558711;1456.4247122386598;1457.628304782295;1479.1347061968868;1479.7558402863622;896.8385690575628;905.5562774240707;914.9908500915038;931.1759093202429;935.2985261054209;4859.465458799529;4871.223402660449;4872.634552408513;4883.8290659826735;4901.769694788863;5143.948560514422;5152.252923326097;5159.74201289934;5224.869378265497;5261.4738526147075;4773.713577185311;4834.6374021948495;4897.159647404497;4962.2459534957725;4967.552920237196;2751.3216937668008;2757.001174148726;2757.696653368128;2787.9266482404014;2791.371941313229;5353.250544923714;5356.384015838151;5447.249139184686;5453.991011662855;5527.668339899538;4829.5994161692715;5205.553389906738;5228.503292187236;5283.709395983181;5368.516833485005;5356.384015838228;5375.75809088592;5395.838124856261;5402.513773760302;5405.243265942692;5142.871428214325;5175.9741201293755;5232.790688372423;5247.921281180862;5255.527002569787;5392.892142157213;5841.860837136717;5855.2973643163095;5874.559408044328;5928.140419639214;6170.426541231957;6214.8135555931585;6221.2845522763655;6221.906671399842;6249.406306400884;4121.361189015707;4127.174565086934;4158.37624356349;4206.432131662309;4257.638100761346;5875.383084776208;5879.588428809942;5894.585299528168;5899.587028908107;5900.616459930091;5736.254286942671;5773.3072031356505;5780.710964451845;5805.274340707411;5842.941570584239;5482.533984611353;5688.260526131742;5748.6838223898085;5752.741126649227;5753.223314852441;5704.600677952503;5706.058500347396;5723.599348045597;5749.425057494217;5759.034097439906;5646.85882852932;5692.31692196939;5808.244928159313;5824.504917081926;5844.298684157929;5711.457411545896;5727.513161381329;5734.885302293847;5776.942230577641;5793.91419089136 08:27:15 INFO - PROCESS | 6980 | |5;yui.html;751.8158051277438;775.1666958020127;785.1677222144524;801.4710291207804;808.8948436703228;13636.454541818328;14300.356483958221;14319.28403579822;14375.353109110101;14397.928010359947;15664.451744188955;15814.683706325866;15829.525114246591;15845.207739613032;15890.126043067627;650.8600650860064;765.2997507280832;784.3411534311192;788.8737801951689;808.1514409869643;785.2069409895989;788.1921030943272;790.8853216283665;798.4251339035885;800.8638531449668;845.5941148248844;851.5657014922404;851.6550796927254;853.9402241843073;854.7179430787825;839.9916000839975;840.109483947012;840.8570543007703;841.9410641255115;844.0673056272792;618.4125081172904;619.4579742725116;619.8388419011045;620.5159975219336;621.5835390288472;15116.244187790566;15173.696526069527;15177.24113794306;15189.392424303014;15194.696106077927;14922.62785397256;14937;15059;15098.320575574016;15397.923010384988;12136.817947730791;12248.510059597606;12269.93865030678;12362.505499780087;12991.805122923164;3698.8335524901177;3755.2489502099415;3761.191343861083;3783.148791521913;3826.253880493305;82573.76139357915;83010;83094;83493.16506834915;85161;11132.666020019413;11269.605563805228;11343.773124537463;11688.240264382788;11766.5881694142;21165.470863228544;21429.142834286453;21564.784352156592;21602.891985539973;21637.134514619553;8232.711855085043;8361.498310101413;8390.748277551684;8790.120987901159;9087.68193113251;4778.259369797687;4784.904301914012;4800.231962885921;4803.18345881201;4909.705417674951;3552.182997910495;3619.873304434332;3625.927481450356;3656.963430365662;3659.249853779969;590.4685782795518;591.2845456996996;595.2113449679192;602.3554796367932;605.7637521366671;724.9093863267092;732.6556518436327;759.7454852624322;785.1245860865095;790.817727497395;8976.640934362684;9191.678291259908;9309.72070837876;9327.766805829908;9580.08989146044;638.6327861479667;652.7650045983443;722.404016686236;744.4007573902952;764.5871229535989;4251.4260574822;4435.334699795057;4474.39595654589;4572.1312950539295;4677.766111694402;69844.6507767458;70637.64681176562;100296;117807;120086;61126;76646.61676691692;92480;95440;101959.4902025485;87220;88723;90088;93069;93758.53120734489;9657.46883921391;10125.199270954032;10236.846447303147;10237.692869213935;10293.897061029294;49518.75240623774;49698;50464.24303635375;50896.49103508917;50985;67035;69565.30434695791;71286;75102.24897751171;75260.24739752532;13729.862701373258;13805.378757955716;13917.860821391656;13928.442862285396;14549.41802327895;14588.85411145875;15366;15408.15255160977;15560.221988900283;15742.9212853935;14413.7837932429;14458.277086145441;14880.107193568421;14943.476978305707;15424.845751542342;14152.43390264378;14227.217503037433;14262.57212283633;14386.28068596545;14983.325750341042;14060.296985150497;14292.28538573088;14636.926815366282;14795;14820.40718371253;10874.401907894826;11388.829167562659;11725.824112638487;11999.940000299943;12138.453769580214;11061.668149955514;12075.57735479254;12119.272843629411;12277.756808836106;12413 08:27:15 INFO - PROCESS | 6980 | __end_tp_report 08:27:15 INFO - PROCESS | 6980 | __start_cc_report 08:27:15 INFO - PROCESS | 6980 | _x_x_mozilla_cycle_collect,310 08:27:15 INFO - PROCESS | 6980 | __end_cc_report 08:27:15 INFO - PROCESS | 6980 | __startTimestamp1470756435568__endTimestamp 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | ------- Summary: start ------- 08:27:15 INFO - PROCESS | 6980 | Number of tests: 6 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | [#0] dojo.html Cycles:165 Average:5474.76 Median:5720.77 stddev:622.81 (10.9%) stddev-sans-first:597.39 08:27:15 INFO - PROCESS | 6980 | Values: 3148.3 3172.7 3180.2 3191.5 3201.2 5476.2 5519.7 5523.9 5579.6 5609.0 5456.1 5500.7 5522.4 5536.9 5551.7 4917.5 4999.1 5003.0 5022.2 5036.3 5047.3 5057.2 5116.1 5143.5 5157.4 5034.7 5041.3 5100.8 5116.8 5126.7 4909.7 4966.4 4976.4 5017.0 5082.8 4971.2 4982.8 4985.4 4996.2 5016.6 5331.0 5397.2 5464.2 5470.8 5477.6 5736.7 5820.5 5829.1 5870.9 5877.9 5894.6 5905.4 5908.4 5912.2 5915.6 5327.8 5523.8 5524.7 5529.8 5535.9 5867.7 5903.9 5951.1 6021.4 6031.6 5720.8 5727.6 5741.6 5744.9 5745.2 5775.1 5813.9 5817.1 5825.3 5835.2 5714.3 5741.5 5838.7 5845.1 5894.7 5875.3 5882.2 5885.8 5895.6 5908.7 4498.8 4501.6 4503.2 4504.8 4544.0 3910.4 3947.7 3972.0 4016.9 4053.0 5616.0 5622.3 5655.1 5662.3 5677.7 5946.3 5953.0 5960.1 5991.4 5997.0 5434.0 5543.5 5639.5 5652.2 5734.5 5069.2 5085.7 5085.9 5086.4 5124.5 6159.2 6192.3 6202.9 6218.3 6219.8 5743.0 5765.7 5848.8 5880.3 5969.0 6065.9 6094.1 6112.2 6117.7 6124.5 5778.8 5784.9 5793.0 5795.3 5808.4 5749.0 5849.2 5954.6 5969.0 5991.3 5785.8 5799.1 5819.8 5844.5 5845.9 5525.3 5761.7 5810.7 5811.7 5812.2 5584.2 5682.7 5685.3 5692.6 5790.3 5813.9 5831.6 5839.8 5844.9 5884.3 5499.8 5705.2 5743.8 5745.7 5746.3 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | [#1] ext.html Cycles:180 Average:64988.41 Median:42396.08 stddev:137339.98 (323.9%) stddev-sans-first:137640.04 08:27:15 INFO - PROCESS | 6980 | Values: 552.4 577.6 584.3 600.5 618.4 39653.4 43389.8 43425.3 43437.6 43554.8 43153.8 44007.3 44036.6 44082.0 44084.0 8818.6 8942.2 8953.1 8958.8 8973.7 8824.5 8861.0 8912.4 8931.2 8933.2 8961.7 8975.8 9030.2 9031.0 9047.6 8925.0 8953.7 8967.3 8991.1 9001.3 8857.6 8944.8 8947.2 8960.6 8964.8 41583.0 41812.6 41820.6 41966.2 42030.2 3475.4 3616.6 3877.5 4089.6 4161.1 32922.8 33765.2 33888.3 33919.3 34023.0 4305.5 4456.9 4474.5 4476.0 4532.5 345267.0 353034.0 354579.0 355522.0 358171.0 57802.7 57937.7 58171.4 58265.7 58398.0 37034.6 37800.8 37807.8 39627.6 39650.8 15531.0 15661.8 15665.9 15682.4 15750.1 12067.9 12094.6 12109.3 12122.0 12189.5 19368.3 19473.5 19571.6 19587.3 19609.5 7228.6 7255.9 7329.7 7332.4 7405.4 949.4 1084.6 1086.7 1128.3 1136.8 32798.1 33255.7 33283.5 33337.8 33509.5 1114.8 1125.2 1133.7 1161.7 1202.3 17247.5 17321.6 17452.7 17453.0 17552.5 647815.0 653599.0 654150.0 654206.0 656205.0 60836.7 61130.0 61314.0 61319.7 61400.7 1308.8 1349.0 1361.5 1361.6 1377.0 30421.7 32414.7 33118.5 33160.0 33296.5 52157.7 52239.0 52357.0 52440.5 52453.7 488747.0 493706.0 493749.0 494306.0 494756.0 29244.6 29299.9 29835.7 29845.0 29983.7 48694.8 49164.3 49449.3 49678.5 49761.3 41717.6 42272.4 42401.2 42883.0 43479.0 41561.6 42145.4 42391.0 42718.0 43257.0 41940.7 42779.6 43180.4 43410.1 43474.8 35281.1 36614.6 37282.0 37707.6 38339.2 28541.4 28838.4 29128.7 29160.9 29330.0 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | [#2] jquery.html Cycles:180 Average:28750.59 Median:12990.69 stddev:78793.03 (606.5%) stddev-sans-first:78985.26 08:27:15 INFO - PROCESS | 6980 | Values: 374.7 383.8 397.8 402.3 415.0 13615.4 18280.0 18414.1 19898.5 19944.0 18632.2 18679.8 19202.2 19275.8 19498.4 1557.7 1559.1 1562.4 1598.9 5680.7 5654.3 5688.9 5757.8 5770.4 5796.9 5677.1 5680.3 5747.0 5752.3 5762.3 5611.2 5669.1 5695.2 5737.1 5773.2 5061.9 5082.2 5089.3 5118.9 5137.9 22427.0 23045.2 23318.4 23367.6 23520.6 2460.7 2489.6 2886.5 2903.3 3160.1 9904.0 10518.5 14757.5 14936.5 15048.8 1966.5 1977.6 1981.1 2017.5 2033.9 84421.0 85116.0 85667.6 86243.0 86628.6 10800.5 10899.8 10963.6 11125.6 11133.8 15163.4 15285.2 15304.5 15332.1 15350.8 7798.2 7890.7 8065.3 8080.9 8199.4 7184.1 7391.3 7415.6 7511.5 7557.9 4576.5 4665.9 4736.3 4768.7 4826.6 1950.8 1975.5 1982.9 1991.0 2067.8 927.3 976.8 992.1 1000.5 1011.2 19399.9 19503.2 19551.0 19568.8 19724.6 975.5 1007.6 1015.2 1017.2 1023.3 10386.6 10783.1 10791.1 10822.5 10841.7 467548.0 475410.0 475566.0 480405.0 484089.0 90101.1 91787.0 91962.5 94356.3 94420.5 963.6 991.2 992.8 1009.2 1009.5 16684.7 16832.6 17362.2 17834.4 18103.9 42769.1 42805.8 43442.3 43613.0 44158.8 55348.7 56678.7 57091.0 58787.7 60624.0 7488.0 7871.7 8415.0 8472.9 8694.0 12851.6 13423.9 13583.9 13616.0 13746.2 11639.2 11998.2 12053.8 12079.8 12364.6 11536.9 11696.5 11713.9 11893.5 12023.3 11793.2 11841.3 11879.4 11979.3 12269.4 7925.9 7943.7 7995.3 8183.5 8207.7 11374.0 11546.0 11573.8 11883.9 12048.3 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | [#3] mootools.html Cycles:180 Average:5952.63 Median:2565.64 stddev:3407.12 (132.8%) stddev-sans-first:3400.08 08:27:15 INFO - PROCESS | 6980 | Values: 1478.6 1505.2 1598.2 1700.8 1734.9 8058.6 8520.5 8643.4 9338.0 9354.7 8599.1 8767.6 8996.1 8999.7 9013.7 2446.2 2469.1 2492.5 2493.7 2495.8 2390.8 2490.4 2494.0 2503.5 2508.4 2438.6 2443.0 2488.5 2489.3 2493.0 2382.6 2388.9 2398.0 2416.1 2416.5 2187.3 2211.6 2217.1 2222.1 2228.3 8910.1 8931.4 8996.4 9099.0 9102.5 5420.6 5464.6 5527.4 5543.7 5544.4 3536.8 3603.6 3626.0 3692.6 3723.9 1247.7 1256.4 1261.6 1275.6 1277.3 12523.4 12653.7 12689.0 12723.4 12728.9 4670.7 4761.6 4815.6 4924.5 4925.5 10597.7 10613.2 10621.5 10646.0 10652.8 5477.9 5502.0 5535.0 5541.5 5567.9 4357.3 4829.9 4957.5 4972.2 5101.5 4078.9 4141.3 4171.2 4192.3 4223.6 1322.9 1334.8 1360.7 1367.5 1383.8 873.6 947.7 970.1 971.3 977.9 5774.9 5868.1 6031.8 6275.8 6325.5 438.4 439.0 442.5 453.4 460.6 4185.5 4243.2 4243.5 4287.4 4295.3 11003.2 11390.4 11393.9 11394.6 11399.9 11346.5 11366.5 11368.2 11372.3 11422.1 7999.8 8261.0 8268.0 8533.8 8541.9 5972.6 6068.4 6141.1 6149.9 6208.3 10171.4 10531.7 10659.0 10704.8 10751.1 10418.9 10433.4 10570.9 10591.5 10618.7 7229.7 7704.6 7738.1 7863.3 7867.2 8641.3 8717.7 8764.0 8774.3 8779.0 7637.1 7850.7 7907.4 7987.8 8077.7 7803.1 7893.0 7932.4 8012.6 8067.4 7137.0 7188.9 7235.3 7242.6 7283.9 4946.1 4950.9 4993.9 5002.3 5092.7 5108.4 5156.4 5189.4 5266.9 5348.2 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | [#4] prototype.html Cycles:180 Average:4705.86 Median:5251.72 stddev:1375.63 (26.2%) stddev-sans-first:1339.74 08:27:15 INFO - PROCESS | 6980 | Values: 332.2 339.0 347.1 348.2 348.7 5443.2 5530.9 5544.7 5579.0 5593.2 5418.6 5428.2 5439.0 5473.2 5493.7 4252.5 4268.3 4296.5 4330.5 4388.6 4320.5 4326.9 4327.7 4347.6 4373.8 4289.0 4312.2 4313.5 4324.1 4324.7 4092.9 4210.4 4236.3 4243.5 4277.4 3752.2 3755.1 3756.3 3768.2 3772.6 5393.1 5398.9 5407.3 5416.4 5419.1 4624.5 4833.2 4876.1 4877.3 4899.8 5702.6 5724.0 5731.9 5755.5 5757.6 4114.1 4120.1 4141.4 4161.3 4162.6 5855.4 5898.2 5902.2 5912.0 5940.9 4206.6 4209.3 4212.5 4220.2 4230.8 4251.6 4274.5 4280.2 4282.0 4294.5 4655.5 4807.9 4835.0 4866.7 4886.0 5726.9 5730.7 5735.4 5790.0 5800.1 1440.5 1456.4 1457.6 1479.1 1479.8 896.8 905.6 915.0 931.2 935.3 4859.5 4871.2 4872.6 4883.8 4901.8 5143.9 5152.3 5159.7 5224.9 5261.5 4773.7 4834.6 4897.2 4962.2 4967.6 2751.3 2757.0 2757.7 2787.9 2791.4 5353.3 5356.4 5447.2 5454.0 5527.7 4829.6 5205.6 5228.5 5283.7 5368.5 5356.4 5375.8 5395.8 5402.5 5405.2 5142.9 5176.0 5232.8 5247.9 5255.5 5392.9 5841.9 5855.3 5874.6 5928.1 6170.4 6214.8 6221.3 6221.9 6249.4 4121.4 4127.2 4158.4 4206.4 4257.6 5875.4 5879.6 5894.6 5899.6 5900.6 5736.3 5773.3 5780.7 5805.3 5842.9 5482.5 5688.3 5748.7 5752.7 5753.2 5704.6 5706.1 5723.6 5749.4 5759.0 5646.9 5692.3 5808.2 5824.5 5844.3 5711.5 5727.5 5734.9 5776.9 5793.9 08:27:15 INFO - PROCESS | 6980 | 08:27:15 INFO - PROCESS | 6980 | [#5] yui.html Cycles:180 Average:20302.55 Median:4523.26 stddev:28232.10 (624.2%) stddev-sans-first:28273.13 08:27:15 INFO - PROCESS | 6980 | Values: 751.8 775.2 785.2 801.5 808.9 13636.5 14300.4 14319.3 14375.4 14397.9 15664.5 15814.7 15829.5 15845.2 15890.1 650.9 765.3 784.3 788.9 808.2 785.2 788.2 790.9 798.4 800.9 845.6 851.6 851.7 853.9 854.7 840.0 840.1 840.9 841.9 844.1 618.4 619.5 619.8 620.5 621.6 15116.2 15173.7 15177.2 15189.4 15194.7 14922.6 14937.0 15059.0 15098.3 15397.9 12136.8 12248.5 12269.9 12362.5 12991.8 3698.8 3755.2 3761.2 3783.1 3826.3 82573.8 83010.0 83094.0 83493.2 85161.0 11132.7 11269.6 11343.8 11688.2 11766.6 21165.5 21429.1 21564.8 21602.9 21637.1 8232.7 8361.5 8390.7 8790.1 9087.7 4778.3 4784.9 4800.2 4803.2 4909.7 3552.2 3619.9 3625.9 3657.0 3659.2 590.5 591.3 595.2 602.4 605.8 724.9 732.7 759.7 785.1 790.8 8976.6 9191.7 9309.7 9327.8 9580.1 638.6 652.8 722.4 744.4 764.6 4251.4 4435.3 4474.4 4572.1 4677.8 69844.7 70637.6 100296.0 117807.0 120086.0 61126.0 76646.6 92480.0 95440.0 101959.5 87220.0 88723.0 90088.0 93069.0 93758.5 9657.5 10125.2 10236.8 10237.7 10293.9 49518.8 49698.0 50464.2 50896.5 50985.0 67035.0 69565.3 71286.0 75102.2 75260.2 13729.9 13805.4 13917.9 13928.4 14549.4 14588.9 15366.0 15408.2 15560.2 15742.9 14413.8 14458.3 14880.1 14943.5 15424.8 14152.4 14227.2 14262.6 14386.3 14983.3 14060.3 14292.3 14636.9 14795.0 14820.4 10874.4 11388.8 11725.8 11999.9 12138.5 11061.7 12075.6 12119.3 12277.8 12413.0 08:27:15 INFO - PROCESS | 6980 | -------- Summary: end -------- 08:27:15 INFO - PROCESS | 6980 | 08:27:16 INFO - TEST-INFO | 6980: exit 0 08:27:16 INFO - TEST-OK | dromaeo_css | took 1113665ms 08:27:16 INFO - TEST-START | kraken 08:27:16 INFO - operating with platform_type : linux_ 08:27:16 INFO - Initialising browser for kraken test... 08:27:16 INFO - TEST-INFO | started process 7229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW01Pil/profile http://localhost:39420/getInfo.html) 08:27:20 INFO - PROCESS | 7229 | __metrics Screen width/height:1600/1200 08:27:20 INFO - PROCESS | 7229 | colorDepth:24 08:27:20 INFO - PROCESS | 7229 | Browser inner width/height: 1024/697 08:27:20 INFO - PROCESS | 7229 | __metrics 08:27:21 ERROR - PROCESS | 7229 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:27:22 INFO - TEST-INFO | 7229: exit 0 08:27:22 INFO - Browser initialized. 08:27:22 INFO - Running cycle 1/1 for kraken test... 08:27:22 INFO - TEST-INFO | started process 7347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW01Pil/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:34 INFO - PROCESS | 7347 | RSS: Main: 163811328 08:27:34 INFO - PROCESS | 7347 | 08:27:36 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:37 INFO - PROCESS | 7347 | RSS: Main: 169660416 08:27:37 INFO - PROCESS | 7347 | 08:27:40 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-dft) 08:27:40 INFO - PROCESS | 7347 | RSS: Main: 168841216 08:27:40 INFO - PROCESS | 7347 | 08:27:43 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-fft) 08:27:44 INFO - PROCESS | 7347 | RSS: Main: 164171776 08:27:44 INFO - PROCESS | 7347 | 08:27:46 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-oscillator) 08:27:46 INFO - PROCESS | 7347 | RSS: Main: 165646336 08:27:46 INFO - PROCESS | 7347 | 08:27:49 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:49 INFO - PROCESS | 7347 | RSS: Main: 165294080 08:27:49 INFO - PROCESS | 7347 | 08:27:52 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39420/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:53 INFO - PROCESS | 7347 | RSS: Main: 165376000 08:27:53 INFO - PROCESS | 7347 | 08:27:57 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39420/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:57 INFO - PROCESS | 7347 | RSS: Main: 163549184 08:27:57 INFO - PROCESS | 7347 | 08:28:00 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39420/tests/kraken/driver.html?testName=json-parse-financial) 08:28:01 INFO - PROCESS | 7347 | RSS: Main: 165629952 08:28:01 INFO - PROCESS | 7347 | 08:28:02 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:03 INFO - PROCESS | 7347 | RSS: Main: 165355520 08:28:03 INFO - PROCESS | 7347 | 08:28:05 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:05 INFO - PROCESS | 7347 | RSS: Main: 165654528 08:28:05 INFO - PROCESS | 7347 | 08:28:07 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:08 INFO - PROCESS | 7347 | RSS: Main: 166154240 08:28:08 INFO - PROCESS | 7347 | 08:28:11 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:11 INFO - PROCESS | 7347 | RSS: Main: 166486016 08:28:11 INFO - PROCESS | 7347 | 08:28:14 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:15 INFO - PROCESS | 7347 | RSS: Main: 166572032 08:28:15 INFO - PROCESS | 7347 | 08:28:16 INFO - PROCESS | 7347 | Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39420/tests/kraken/driver.html?testName=ai-astar) 08:28:17 INFO - PROCESS | 7347 | RSS: Main: 167473152 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | __start_tp_report 08:28:17 INFO - PROCESS | 7347 | _x_x_mozilla_page_load 08:28:17 INFO - PROCESS | 7347 | _x_x_mozilla_page_load_details 08:28:17 INFO - PROCESS | 7347 | |i|pagename|runs| 08:28:17 INFO - PROCESS | 7347 | |0;ai-astar;102;110;107;110;112;111;113;111;111;109 08:28:17 INFO - PROCESS | 7347 | |1;audio-beat-detection;151;124;140;175;121;147;150;122;182;120 08:28:17 INFO - PROCESS | 7347 | |2;audio-dft;162;163;166;164;162;164;168;163;162;163 08:28:17 INFO - PROCESS | 7347 | |3;audio-fft;77;75;76;170;77;76;76;75;173;75 08:28:17 INFO - PROCESS | 7347 | |4;audio-oscillator;85;84;158;86;84;84;143;84;83;148 08:28:17 INFO - PROCESS | 7347 | |5;imaging-gaussian-blur;118;118;117;117;117;119;117;121;117;118 08:28:17 INFO - PROCESS | 7347 | |6;imaging-darkroom;147;146;146;147;147;148;147;147;147;147 08:28:17 INFO - PROCESS | 7347 | |7;imaging-desaturate;95;99;96;95;95;95;96;96;96;95 08:28:17 INFO - PROCESS | 7347 | |8;json-parse-financial;53;52;54;51;54;52;54;52;66;53 08:28:17 INFO - PROCESS | 7347 | |9;json-stringify-tinderbox;61;60;61;61;62;62;61;61;61;62 08:28:17 INFO - PROCESS | 7347 | |10;stanford-crypto-aes;76;77;77;77;77;78;85;77;79;85 08:28:17 INFO - PROCESS | 7347 | |11;stanford-crypto-ccm;128;125;133;126;128;127;126;127;136;131 08:28:17 INFO - PROCESS | 7347 | |12;stanford-crypto-pbkdf2;162;164;160;160;163;160;164;160;160;160 08:28:17 INFO - PROCESS | 7347 | |13;stanford-crypto-sha256-iterative;65;64;64;63;67;63;63;66;61;62 08:28:17 INFO - PROCESS | 7347 | __end_tp_report 08:28:17 INFO - PROCESS | 7347 | __start_cc_report 08:28:17 INFO - PROCESS | 7347 | _x_x_mozilla_cycle_collect,881 08:28:17 INFO - PROCESS | 7347 | __end_cc_report 08:28:17 INFO - PROCESS | 7347 | __startTimestamp1470756497032__endTimestamp 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | ------- Summary: start ------- 08:28:17 INFO - PROCESS | 7347 | Number of tests: 14 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:1.74 08:28:17 INFO - PROCESS | 7347 | Values: 102.0 110.0 107.0 110.0 112.0 111.0 113.0 111.0 111.0 109.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:148.50 stddev:22.35 (15.1%) stddev-sans-first:23.53 08:28:17 INFO - PROCESS | 7347 | Values: 151.0 124.0 140.0 175.0 121.0 147.0 150.0 122.0 182.0 120.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.95 (1.2%) stddev-sans-first:1.96 08:28:17 INFO - PROCESS | 7347 | Values: 162.0 163.0 166.0 164.0 162.0 164.0 168.0 163.0 162.0 163.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.33 (53.1%) stddev-sans-first:42.25 08:28:17 INFO - PROCESS | 7347 | Values: 77.0 75.0 76.0 170.0 77.0 76.0 76.0 75.0 173.0 75.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:84.00 stddev:31.80 (37.9%) stddev-sans-first:32.98 08:28:17 INFO - PROCESS | 7347 | Values: 85.0 84.0 158.0 86.0 84.0 84.0 143.0 84.0 83.0 148.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.29 (1.1%) stddev-sans-first:1.36 08:28:17 INFO - PROCESS | 7347 | Values: 118.0 118.0 117.0 117.0 117.0 119.0 117.0 121.0 117.0 118.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:28:17 INFO - PROCESS | 7347 | Values: 147.0 146.0 146.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 08:28:17 INFO - PROCESS | 7347 | Values: 95.0 99.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.50 stddev:4.31 (8.0%) stddev-sans-first:4.55 08:28:17 INFO - PROCESS | 7347 | Values: 53.0 52.0 54.0 51.0 54.0 52.0 54.0 52.0 66.0 53.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 08:28:17 INFO - PROCESS | 7347 | Values: 61.0 60.0 61.0 61.0 62.0 62.0 61.0 61.0 61.0 62.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:77.50 stddev:3.36 (4.3%) stddev-sans-first:3.41 08:28:17 INFO - PROCESS | 7347 | Values: 76.0 77.0 77.0 77.0 77.0 78.0 85.0 77.0 79.0 85.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:128.00 stddev:3.53 (2.8%) stddev-sans-first:3.73 08:28:17 INFO - PROCESS | 7347 | Values: 128.0 125.0 133.0 126.0 128.0 127.0 126.0 127.0 136.0 131.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:1.77 (1.1%) stddev-sans-first:1.86 08:28:17 INFO - PROCESS | 7347 | Values: 162.0 164.0 160.0 160.0 163.0 160.0 164.0 160.0 160.0 160.0 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - PROCESS | 7347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.81 (2.8%) stddev-sans-first:1.87 08:28:17 INFO - PROCESS | 7347 | Values: 65.0 64.0 64.0 63.0 67.0 63.0 63.0 66.0 61.0 62.0 08:28:17 INFO - PROCESS | 7347 | -------- Summary: end -------- 08:28:17 INFO - PROCESS | 7347 | 08:28:17 INFO - TEST-INFO | 7347: exit 0 08:28:18 INFO - TEST-OK | kraken | took 61690ms 08:28:18 INFO - SUITE-END | took 1175s 08:28:18 INFO - Completed test suite (00:19:35) 08:28:18 INFO - javascript benchmark 08:28:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7307.943920236805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.2758965437947, 3172.682731726826, 3180.1572583265424, 3191.505316675916, 3201.151694800878, 5476.17857321402, 5519.668819870805, 5523.889522209553, 5579.553635709143, 5608.971955140229, 5456.127019676853, 5500.697461639608, 5522.420145884685, 5536.889262214753, 5551.694656793875, 4917.50824917509, 4999.125153098212, 5003.024410240005, 5022.246663000561, 5036.320096786942, 5047.343845300106, 5057.216131499605, 5116.053530096944, 5143.485651434864, 5157.432682404932, 5034.723090230036, 5041.319421878073, 5100.77046532905, 5116.846494605149, 5126.692398456086, 4909.656324057281, 4966.379202599675, 4976.42771081323, 5017.0, 5082.822101226477, 4971.229459433794, 4982.77577509013, 4985.351904252424, 4996.225585034325, 5016.623753218487, 5330.973345133289, 5397.163439666858, 5464.207689884945, 5470.753816078286, 5477.643953143033, 5736.684482353469, 5820.505257053155, 5829.067349224146, 5870.853228669317, 5877.85305367365, 5894.616849904743, 5905.379935106838, 5908.438698323653, 5912.231409916726, 5915.645061296336, 5327.786888524493, 5523.834284971457, 5524.696141712164, 5529.751161197756, 5535.916961245584, 5867.70661466925, 5903.852403689856, 5951.077582974646, 6021.42796434338, 6031.577789554777, 5720.771169153188, 5727.627704199213, 5741.569382296345, 5744.913826292609, 5745.195672605839, 5775.104858746901, 5813.88372232553, 5817.069268917037, 5825.300963884361, 5835.153902684087, 5714.257146570919, 5741.483266505951, 5838.737256823453, 5845.1232315153065, 5894.705264736746, 5875.265591801025, 5882.23530940975, 5885.823425297248, 5895.587308888336, 5908.704564771744, 4498.797554110073, 4501.639868810487, 4503.189425903303, 4504.774761261924, 4544.0457503924545, 3910.432987216838, 3947.703922205789, 3972.0, 4016.9397459038137, 4053.047533829548, 5615.989121958087, 5622.32532096151, 5655.066913959151, 5662.320521537359, 5677.716114194273, 5946.286445626552, 5953.047512397996, 5960.135780311917, 5991.400859914061, 5996.970015149896, 5434.0, 5543.501084902297, 5639.548836093103, 5652.152177173457, 5734.483896449339, 5069.239614057921, 5085.720285384339, 5085.8728531787, 5086.364204474441, 5124.538791508782, 6159.19930409044, 6192.256929168529, 6202.906956395657, 6218.2538095427935, 6219.844503887439, 5742.971285143548, 5765.711714414347, 5848.795292164754, 5880.26496687914, 5968.970155149196, 6065.909011364744, 6094.116353128683, 6112.235970503687, 6117.694115294306, 6124.510039196943, 5778.797742079007, 5784.913226301524, 5792.9710351447975, 5795.304563452412, 5808.419158084327, 5749.0, 5849.210356601804, 5954.612950158225, 5969.04495280753, 5991.3409524953095, 5785.797497087582, 5799.072148456226, 5819.76720931158, 5844.47399734026, 5845.941540584709, 5525.310718231051, 5761.711914404347, 5810.73851676684, 5811.738471768866, 5812.157237200667, 5584.246126772834, 5682.687452190004, 5685.260916080883, 5692.573057020657, 5790.305163380422, 5813.854653633693, 5831.562632802472, 5839.839259473852, 5844.883102337844, 5884.293884733859, 5499.752511137089, 5705.201271821865, 5743.827685169452, 5745.712714364181, 5746.281714785652], "value": 5432.455273800028, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.3674224722881, 577.5899111630742, 584.3105135939595, 600.5375860587346, 618.3692633513818, 39653.405198922, 43389.78305108478, 43425.34861977073, 43437.56562434375, 43554.78222608891, 43153.78423107888, 44007.339889901596, 44036.559634403646, 44082.0, 44084.0, 8818.647254109828, 8942.19520243178, 8953.05992870749, 8958.820823583525, 8973.685920992766, 8824.514651694155, 8860.955695221515, 8912.376133670645, 8931.24084452819, 8933.196012358887, 8961.731148065568, 8975.820483590323, 9030.187283144516, 9031.0, 9047.638094476213, 8924.955375223148, 8953.686620968267, 8967.327450441211, 8991.100889911022, 9001.279897608176, 8857.557122143931, 8944.821103577957, 8947.150020748019, 8960.596773145224, 8964.775880602972, 41583.0, 41812.581874181174, 41820.58179418197, 41966.16067678629, 42030.159396812196, 3475.3679582955715, 3616.584092829332, 3877.5346958364894, 4089.6319331260033, 4161.126163505667, 32922.83538582316, 33765.155871103176, 33888.32223355544, 33919.32161356784, 34023.0, 4305.495563929563, 4456.910861782779, 4474.507804141542, 4475.977620111878, 4532.5240849710635, 345267.0, 353034.0, 354579.0, 355522.0, 358171.0, 57802.7109864448, 57937.71031144902, 58171.418285817446, 58265.70867145637, 58398.0, 37034.629653703654, 37800.81099594484, 37807.81096094502, 39627.60372396239, 39650.801745991084, 15531.0, 15661.765073523906, 15665.921670391575, 15682.372705091668, 15750.133742644264, 12067.87932120685, 12094.576689815814, 12109.333986630643, 12122.0, 12189.451474683661, 19368.28010711841, 19473.51316217106, 19571.608567828847, 19587.319677293424, 19609.509762256057, 7228.566286022856, 7255.8911616325795, 7329.670164842595, 7332.376747976375, 7405.407567394704, 949.3591825517748, 1084.5986984815668, 1086.7283179205199, 1128.2948157401624, 1136.8408422820812, 32798.08643847804, 33255.66744332574, 33283.500747488804, 33337.83331083329, 33509.49735753966, 1114.8383484394717, 1125.178619607691, 1133.6825688807148, 1161.7095726068483, 1202.3447221264432, 17247.482575522754, 17321.56696082583, 17452.65094698099, 17453.0, 17552.473425797245, 647815.0, 653599.0, 654150.0, 654206.0, 656205.0, 60836.69581652152, 61130.0, 61314.0, 61319.6934015336, 61400.692996535625, 1308.8167656528094, 1348.9545602158405, 1361.4758318047623, 1361.598328493097, 1376.9655758605916, 30421.695783041887, 32414.675853241166, 33118.5032224512, 33160.0, 33296.500552492216, 52157.7392113037, 52238.99999999848, 52357.0, 52440.47559524356, 52453.73773131263, 488747.0, 493706.0, 493749.0, 494306.0, 494756.0, 29244.561331579618, 29299.85350073236, 29835.70164298329, 29845.0, 29983.70016299809, 48694.75652621714, 49164.26253606127, 49449.25826112539, 49678.503214968834, 49761.25358119704, 41717.58282417258, 42272.365914510694, 42401.15197696091, 42883.0, 43479.0, 41561.58438415698, 42145.36781948212, 42391.0, 42718.0, 43257.0, 41940.74177774672, 42779.57220427756, 43180.352294716235, 43410.131797364505, 43474.782626086664, 35281.11797204988, 36614.63385366219, 37282.0, 37707.62292377151, 38339.2332153361, 28541.429171416872, 28838.42323153567, 29128.7087129126, 29160.854195728887, 29330.0], "value": 20350.489626579987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.7208329794304, 383.8061778801705, 397.7911596411884, 402.27590337392684, 415.0391842883724, 13615.387307571158, 18280.0, 18414.079296035212, 19898.502537436572, 19944.00279986, 18632.161552730126, 18679.81320186798, 19202.23191072359, 19275.807241927578, 19498.415047548562, 1557.7429724095512, 1559.0723519505875, 1562.4375224919077, 1598.856102950734, 5680.659160450376, 5654.264945557093, 5688.857778555528, 5757.827265182052, 5770.365259821417, 5796.855078623026, 5677.148427735831, 5680.346760122577, 5746.9712651436685, 5752.309722833266, 5762.308522977228, 5611.2144299798065, 5669.121286200645, 5695.174199741055, 5737.13942908565, 5773.191753154561, 5061.924071138936, 5082.23766435034, 5089.338386009795, 5118.897622047575, 5137.948620513785, 22427.0, 23045.19341823045, 23318.417039574146, 23367.649485257563, 23520.64719029216, 2460.729319774823, 2489.55188066148, 2886.480433521965, 2903.3177203357195, 3160.067780004904, 9904.0, 10518.526666300035, 14757.465476843248, 14936.477223297132, 15048.849511504965, 1966.5476940303668, 1977.6143651987868, 1981.0986001369486, 2017.5157962088992, 2033.9389818305474, 84421.0, 85116.0, 85667.57166214191, 86243.0, 86628.56685716595, 10800.51397687106, 10899.83650245247, 10963.56145754177, 11125.554977800797, 11133.832992505118, 15163.393464261526, 15285.159316237714, 15304.540863774104, 15332.080075195525, 15350.846491535165, 7798.1811909749795, 7890.723824666109, 8065.314448271963, 8080.9191908080165, 8199.42604017713, 7184.065396800613, 7391.334779869838, 7415.555066696015, 7511.525919262397, 7557.924420755722, 4576.519465456079, 4665.906681866411, 4736.265878788793, 4768.666193366431, 4826.58973987208, 1950.8049195080662, 1975.4863735428605, 1982.9039368821989, 1990.999045958802, 2067.824234940017, 927.2628260532757, 976.8437050071955, 992.1417973453056, 1000.4997501249376, 1011.2415688233824, 19399.90300048491, 19503.219871204994, 19551.0, 19568.804311956697, 19724.603273772336, 975.5219942228257, 1007.6473234368059, 1015.1878497202209, 1017.1557607186018, 1023.3194925374543, 10386.584536618602, 10783.13734901206, 10791.082757965503, 10822.458877056273, 10841.728956776144, 467548.0, 475410.0, 475566.0, 480405.0, 484089.0, 90101.09898901058, 91787.0, 91962.54018729864, 94356.33861968304, 94420.52789736008, 963.6482683820356, 991.2417000994245, 992.7865508915473, 1009.1724785675675, 1009.4649835587151, 16684.749728754323, 16832.57918552046, 17362.218700158777, 17834.37579684705, 18103.909480452512, 42769.144617108104, 42805.78597106995, 43442.34836477392, 43613.0, 44158.77920610376, 55348.72325638346, 56678.716606418355, 57091.0, 58787.70606146942, 60624.0, 7487.962560187382, 7871.685132594861, 8415.0, 8472.872906906277, 8693.956530217309, 12851.550195743104, 13423.865761342262, 13583.932080339535, 13616.0, 13746.175229486264, 11639.185257031926, 11998.220115692453, 12053.758924821279, 12079.818802717791, 12364.62906112818, 11536.94231528837, 11696.47365868555, 11713.941430292794, 11893.524259029542, 12023.27860328383, 11793.174477786815, 11841.28952262867, 11879.406029698308, 11979.281243125091, 12269.447874845475, 7925.881111783213, 7943.6822527100585, 7995.2804247618, 8183.5499047550575, 8207.71273005442, 11374.0, 11545.960863522323, 11573.826392604286, 11883.881161188277, 12048.337341445955], "value": 9062.165036490424, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.593386818625, 1505.2248092232503, 1598.2328482328483, 1700.8469237768597, 1734.9132543372828, 8058.5567793771315, 8520.531370774605, 8643.394962352639, 9337.953310233448, 9354.672586459466, 8599.140085991397, 8767.56162191891, 8996.100389961, 8999.685011024616, 9013.729588112366, 2446.217210492643, 2469.061756532515, 2492.476579918219, 2493.650888875559, 2495.800335973118, 2390.784829365357, 2490.3525083478244, 2494.0397946790526, 2503.4617557225192, 2508.385445565839, 2438.634204869275, 2442.9511409771794, 2488.4774197418565, 2489.3029951613485, 2493.0401795308753, 2382.5592265430864, 2388.868612226327, 2398.028798336668, 2416.1422694943394, 2416.516696660675, 2187.332863476639, 2211.5576884623138, 2217.1020736601704, 2222.0667319725753, 2228.253535065755, 8910.108989101038, 8931.37480376374, 8996.415233009833, 9098.954505227432, 9102.453852768855, 5420.566354691615, 5464.562834973192, 5527.447255274481, 5543.667379957215, 5544.390117087117, 3536.7877927324444, 3603.621619729917, 3625.963740362589, 3692.593814680383, 3723.9069023274365, 1247.7379750252458, 1256.3655354046148, 1261.564760157744, 1275.609585551753, 1277.3485522383558, 12523.436445359981, 12653.746925061447, 12689.0, 12723.427445764963, 12728.854403103673, 4670.660433920052, 4761.571458568746, 4815.638827087912, 4924.532169443897, 4925.532074452921, 10597.735056623493, 10613.248813945767, 10621.468926553796, 10646.0, 10652.840207396895, 5477.917831232535, 5502.0, 5535.0, 5541.501264886179, 5567.888642227133, 4357.281048626941, 4829.879253018703, 4957.479464656231, 4972.204447288416, 5101.464346243591, 4078.8592490479637, 4141.316682747313, 4171.205451515866, 4192.287311157111, 4223.640990515779, 1322.8875545578733, 1334.813126162338, 1360.7006458579096, 1367.5145323410245, 1383.8201033865735, 873.6461732998146, 947.7441090905417, 970.0687340153531, 971.3491960386558, 977.8875429325576, 5774.94225057744, 5868.090445980794, 6031.7587296507645, 6275.843103922439, 6325.493960483151, 438.41033809526135, 438.9890252743643, 442.46019855775904, 453.4445304501959, 460.62459095836783, 4185.518665353523, 4243.193793179286, 4243.533211346749, 4287.442632457823, 4295.334223195409, 11003.22977391591, 11390.430478476042, 11393.886061139448, 11394.601188958346, 11399.943000285111, 11346.48940797666, 11366.488508017159, 11368.204225704287, 11372.31766094037, 11422.14333924959, 7999.84000320002, 8260.958695206486, 8268.049174345027, 8533.786655333666, 8541.871871921927, 5972.611780234271, 6068.362821903636, 6141.07883817431, 6149.938500614937, 6208.255009398901, 10171.389716617026, 10531.684049478528, 10659.0, 10704.839427408438, 10751.139908807432, 10418.947905260426, 10433.373997560171, 10570.947145264532, 10591.4704264788, 10618.681439556825, 7229.710811567478, 7704.576248306173, 7738.148803631483, 7863.292303692695, 7867.17394673551, 8641.308695304235, 8717.694880679146, 8764.035956044703, 8774.29805615562, 8779.0, 7637.121731000784, 7850.685972561034, 7907.367410607253, 7987.760367188994, 8077.717279895411, 7803.102643196105, 7892.960535197517, 7932.444728868923, 8012.559309238048, 8067.435279530377, 7136.964315178391, 7188.856222875618, 7235.312645298688, 7242.565446073252, 7283.890741638986, 4946.08497427977, 4950.8762280943265, 4993.850184494471, 5002.349694539832, 5092.745362731775, 5108.361454818148, 5156.432792392909, 5189.415667007416, 5266.868328291824, 5348.171033489815], "value": 4686.36423632536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1844870842081, 338.9576302962129, 347.0802373709669, 348.19566800690404, 348.6861824358076, 5443.1835224716315, 5530.861728456781, 5544.695041772701, 5579.0, 5593.216949627051, 5418.566514678826, 5428.240046393508, 5439.0209762242785, 5473.17902314653, 5493.697846618435, 4252.489701235856, 4268.317069268917, 4296.462942132233, 4330.545292744264, 4388.648908087353, 4320.546342634026, 4326.935095973563, 4327.697061205717, 4347.586979236968, 4373.846915357964, 4289.0, 4312.22379971605, 4313.460817397825, 4324.113556720865, 4324.675649326297, 4092.897677558055, 4210.410542524049, 4236.279832428495, 4243.490781106287, 4277.422547956017, 3752.212035472554, 3755.0800053986677, 3756.3284338469393, 3768.152165762709, 3772.641599048086, 5393.083175860113, 5398.91901621476, 5407.297051383334, 5416.350037995427, 5419.132938729824, 4624.5375462453485, 4833.202521583935, 4876.097921884428, 4877.268409738532, 4899.779509922062, 5702.572307076985, 5724.0, 5731.856703582402, 5755.453231942959, 5757.596968212227, 4114.136031433402, 4120.134771697947, 4141.399497072907, 4161.271777438936, 4162.646175075122, 5855.4144585541535, 5898.233229680157, 5902.203202567642, 5911.970440147815, 5940.940590594082, 4206.642435392964, 4209.326507758805, 4212.4523811904255, 4220.155968806251, 4230.809613567335, 4251.553586873396, 4274.508431530352, 4280.186764514732, 4282.0, 4294.549072347359, 4655.464621568563, 4807.855764327076, 4835.0, 4866.732329721899, 4885.95114048855, 5726.914096288559, 5730.739237367772, 5735.369109397963, 5789.9710501447225, 5800.129980502874, 1440.5030264558711, 1456.4247122386598, 1457.628304782295, 1479.1347061968868, 1479.7558402863622, 896.8385690575628, 905.5562774240707, 914.9908500915038, 931.1759093202429, 935.2985261054209, 4859.465458799529, 4871.223402660449, 4872.634552408513, 4883.8290659826735, 4901.769694788863, 5143.948560514422, 5152.252923326097, 5159.74201289934, 5224.869378265497, 5261.4738526147075, 4773.713577185311, 4834.6374021948495, 4897.159647404497, 4962.2459534957725, 4967.552920237196, 2751.3216937668008, 2757.001174148726, 2757.696653368128, 2787.9266482404014, 2791.371941313229, 5353.250544923714, 5356.384015838151, 5447.249139184686, 5453.991011662855, 5527.668339899538, 4829.5994161692715, 5205.553389906738, 5228.503292187236, 5283.709395983181, 5368.516833485005, 5356.384015838228, 5375.75809088592, 5395.838124856261, 5402.513773760302, 5405.243265942692, 5142.871428214325, 5175.9741201293755, 5232.790688372423, 5247.921281180862, 5255.527002569787, 5392.892142157213, 5841.860837136717, 5855.2973643163095, 5874.559408044328, 5928.140419639214, 6170.426541231957, 6214.8135555931585, 6221.2845522763655, 6221.906671399842, 6249.406306400884, 4121.361189015707, 4127.174565086934, 4158.37624356349, 4206.432131662309, 4257.638100761346, 5875.383084776208, 5879.588428809942, 5894.585299528168, 5899.587028908107, 5900.616459930091, 5736.254286942671, 5773.3072031356505, 5780.710964451845, 5805.274340707411, 5842.941570584239, 5482.533984611353, 5688.260526131742, 5748.6838223898085, 5752.741126649227, 5753.223314852441, 5704.600677952503, 5706.058500347396, 5723.599348045597, 5749.425057494217, 5759.034097439906, 5646.85882852932, 5692.31692196939, 5808.244928159313, 5824.504917081926, 5844.298684157929, 5711.457411545896, 5727.513161381329, 5734.885302293847, 5776.942230577641, 5793.91419089136], "value": 4267.056071981557, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.8158051277438, 775.1666958020127, 785.1677222144524, 801.4710291207804, 808.8948436703228, 13636.454541818328, 14300.356483958221, 14319.28403579822, 14375.353109110101, 14397.928010359947, 15664.451744188955, 15814.683706325866, 15829.525114246591, 15845.207739613032, 15890.126043067627, 650.8600650860064, 765.2997507280832, 784.3411534311192, 788.8737801951689, 808.1514409869643, 785.2069409895989, 788.1921030943272, 790.8853216283665, 798.4251339035885, 800.8638531449668, 845.5941148248844, 851.5657014922404, 851.6550796927254, 853.9402241843073, 854.7179430787825, 839.9916000839975, 840.109483947012, 840.8570543007703, 841.9410641255115, 844.0673056272792, 618.4125081172904, 619.4579742725116, 619.8388419011045, 620.5159975219336, 621.5835390288472, 15116.244187790566, 15173.696526069527, 15177.24113794306, 15189.392424303014, 15194.696106077927, 14922.62785397256, 14937.0, 15059.0, 15098.320575574016, 15397.923010384988, 12136.817947730791, 12248.510059597606, 12269.93865030678, 12362.505499780087, 12991.805122923164, 3698.8335524901177, 3755.2489502099415, 3761.191343861083, 3783.148791521913, 3826.253880493305, 82573.76139357915, 83010.0, 83094.0, 83493.16506834915, 85161.0, 11132.666020019413, 11269.605563805228, 11343.773124537463, 11688.240264382788, 11766.5881694142, 21165.470863228544, 21429.142834286453, 21564.784352156592, 21602.891985539973, 21637.134514619553, 8232.711855085043, 8361.498310101413, 8390.748277551684, 8790.120987901159, 9087.68193113251, 4778.259369797687, 4784.904301914012, 4800.231962885921, 4803.18345881201, 4909.705417674951, 3552.182997910495, 3619.873304434332, 3625.927481450356, 3656.963430365662, 3659.249853779969, 590.4685782795518, 591.2845456996996, 595.2113449679192, 602.3554796367932, 605.7637521366671, 724.9093863267092, 732.6556518436327, 759.7454852624322, 785.1245860865095, 790.817727497395, 8976.640934362684, 9191.678291259908, 9309.72070837876, 9327.766805829908, 9580.08989146044, 638.6327861479667, 652.7650045983443, 722.404016686236, 744.4007573902952, 764.5871229535989, 4251.4260574822, 4435.334699795057, 4474.39595654589, 4572.1312950539295, 4677.766111694402, 69844.6507767458, 70637.64681176562, 100296.0, 117807.0, 120086.0, 61126.0, 76646.61676691692, 92480.0, 95440.0, 101959.4902025485, 87220.0, 88723.0, 90088.0, 93069.0, 93758.53120734489, 9657.46883921391, 10125.199270954032, 10236.846447303147, 10237.692869213935, 10293.897061029294, 49518.75240623774, 49698.0, 50464.24303635375, 50896.49103508917, 50985.0, 67035.0, 69565.30434695791, 71286.0, 75102.24897751171, 75260.24739752532, 13729.862701373258, 13805.378757955716, 13917.860821391656, 13928.442862285396, 14549.41802327895, 14588.85411145875, 15366.0, 15408.15255160977, 15560.221988900283, 15742.9212853935, 14413.7837932429, 14458.277086145441, 14880.107193568421, 14943.476978305707, 15424.845751542342, 14152.43390264378, 14227.217503037433, 14262.57212283633, 14386.28068596545, 14983.325750341042, 14060.296985150497, 14292.28538573088, 14636.926815366282, 14795.0, 14820.40718371253, 10874.401907894826, 11388.829167562659, 11725.824112638487, 11999.940000299943, 12138.453769580214, 11061.668149955514, 12075.57735479254, 12119.272843629411, 12277.756808836106, 12413.0], "value": 7602.5564003539575, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 107.0, 110.0, 112.0, 111.0, 113.0, 111.0, 111.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 140.0, 175.0, 121.0, 147.0, 150.0, 122.0, 182.0, 120.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 164.0, 162.0, 164.0, 168.0, 163.0, 162.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 170.0, 77.0, 76.0, 76.0, 75.0, 173.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 158.0, 86.0, 84.0, 84.0, 143.0, 84.0, 83.0, 148.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 121.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 51.0, 54.0, 52.0, 54.0, 52.0, 66.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 77.0, 77.0, 78.0, 85.0, 77.0, 79.0, 85.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 133.0, 126.0, 128.0, 127.0, 126.0, 127.0, 136.0, 131.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 160.0, 160.0, 163.0, 160.0, 164.0, 160.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 67.0, 63.0, 63.0, 66.0, 61.0, 62.0], "value": 63.8, "unit": "score"}]}]} 08:28:18 INFO - Return code: 0 08:28:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:28:18 ERROR - # TBPL SUCCESS # 08:28:18 INFO - Running post-action listener: _resource_record_post_action 08:28:18 INFO - [mozharness: 2016-08-09 15:28:18.370727Z] Finished run-tests step (success) 08:28:18 INFO - Running post-run listener: _resource_record_post_run 08:28:18 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554643456; Read time: 36; Write time: 566476 08:28:18 INFO - TinderboxPrint: CPU usage
13.4% 08:28:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 08:28:18 INFO - TinderboxPrint: I/O write bytes / time
554,643,456 / 566,476 08:28:18 INFO - TinderboxPrint: CPU idle
8,243.1 (86.6%) 08:28:18 INFO - TinderboxPrint: CPU user
1,217.6 (12.8%) 08:28:18 INFO - TinderboxPrint: Swap in / out
0 / 0 08:28:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258625536; Read time: 0; Write time: 336288 08:28:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296017920; Read time: 28; Write time: 230188 08:28:19 INFO - Running post-run listener: _upload_blobber_files 08:28:19 INFO - Blob upload gear active. 08:28:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:19 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 08:28:19 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'] 08:28:19 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 08:28:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:28:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:23 INFO - (blobuploader) - INFO - Done attempting. 08:28:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:28:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:28:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:24 INFO - (blobuploader) - INFO - Done attempting. 08:28:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:28:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:28:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:25 INFO - (blobuploader) - INFO - Done attempting. 08:28:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:25 INFO - Return code: 0 08:28:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64cd9a1da4e262fb82957eba702918d4875537bbbe26e6b72aad413be8ad81b9c7eec39586fb14ddf9f63a9f001999a01f5c1603e5fa5c2c8f199454808a3f5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e60b4dded4c123be15e8452d27405bbb52815bc27eb66db35f596a9e2ac587cfa53779764298ebf3b99aacd1775c6fa875ee5dac7736998655100c7fc58b414", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f83b8a50a7f07152a9b92a9b4bff9b08ade5252a749c3095a596328d5df92f6862433cb4768dc8b750bf235c749b64be89d765c54f98575b49fc9cf7dc35a3"} 08:28:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:25 INFO - Contents: 08:28:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64cd9a1da4e262fb82957eba702918d4875537bbbe26e6b72aad413be8ad81b9c7eec39586fb14ddf9f63a9f001999a01f5c1603e5fa5c2c8f199454808a3f5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e60b4dded4c123be15e8452d27405bbb52815bc27eb66db35f596a9e2ac587cfa53779764298ebf3b99aacd1775c6fa875ee5dac7736998655100c7fc58b414", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f83b8a50a7f07152a9b92a9b4bff9b08ade5252a749c3095a596328d5df92f6862433cb4768dc8b750bf235c749b64be89d765c54f98575b49fc9cf7dc35a3"} 08:28:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:25 INFO - Copying logs to upload dir... 08:28:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.228415 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-09 08:28:25.205212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 08:28:25.208511) ========= 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=232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321 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/64cd9a1da4e262fb82957eba702918d4875537bbbe26e6b72aad413be8ad81b9c7eec39586fb14ddf9f63a9f001999a01f5c1603e5fa5c2c8f199454808a3f5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e60b4dded4c123be15e8452d27405bbb52815bc27eb66db35f596a9e2ac587cfa53779764298ebf3b99aacd1775c6fa875ee5dac7736998655100c7fc58b414", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f83b8a50a7f07152a9b92a9b4bff9b08ade5252a749c3095a596328d5df92f6862433cb4768dc8b750bf235c749b64be89d765c54f98575b49fc9cf7dc35a3"} build_url:https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/AL__tbS8SgmL1ONxLfbxGA/artifacts/public/build/firefox-51.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/64cd9a1da4e262fb82957eba702918d4875537bbbe26e6b72aad413be8ad81b9c7eec39586fb14ddf9f63a9f001999a01f5c1603e5fa5c2c8f199454808a3f5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e60b4dded4c123be15e8452d27405bbb52815bc27eb66db35f596a9e2ac587cfa53779764298ebf3b99aacd1775c6fa875ee5dac7736998655100c7fc58b414", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f83b8a50a7f07152a9b92a9b4bff9b08ade5252a749c3095a596328d5df92f6862433cb4768dc8b750bf235c749b64be89d765c54f98575b49fc9cf7dc35a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 08:28:25.233914) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:28:25.234247) ========= 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=232498196343f89f466a4a9a000001c8-1470755145.987904-2090440321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:28:25.318799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 08:28:25.319107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 08:28:25.319406) ========= ========= Total master_lag: 0.16 =========