builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1467234678.04 results: success (0) buildid: 20160629113018 builduid: b46f1eac51e54718b5ded84d24bab64a revision: 5e2a5623088f114559c36a769dbea5cab6dc1e6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.043806) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.044487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.044772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.060011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.060378) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 14:11:18-- 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% 13.3M=0.001s 2016-06-29 14:11:18 (13.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.163083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.163727) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019646 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.226384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.226788) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5e2a5623088f114559c36a769dbea5cab6dc1e6a --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 5e2a5623088f114559c36a769dbea5cab6dc1e6a --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=516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 14:11:18,345 truncating revision to first 12 chars 2016-06-29 14:11:18,345 Setting DEBUG logging. 2016-06-29 14:11:18,345 attempt 1/10 2016-06-29 14:11:18,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5e2a5623088f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 14:11:18,731 unpacking tar archive at: fx-team-5e2a5623088f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.962253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.962583) ========= script_repo_revision: 5e2a5623088f114559c36a769dbea5cab6dc1e6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.963004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.963290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 14:11:18.974033) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-29 14:11:18.974430) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:11:19 INFO - MultiFileLogger online at 20160629 14:11:19 in /builds/slave/test 14:11:19 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 14:11:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:19 INFO - {'append_to_log': False, 14:11:19 INFO - 'base_work_dir': '/builds/slave/test', 14:11:19 INFO - 'blob_upload_branch': 'Fx-Team', 14:11:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:19 INFO - 'branch': 'Fx-Team', 14:11:19 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:19 INFO - 'config_files': ('talos/linux_config.py',), 14:11:19 INFO - 'default_actions': ('clobber', 14:11:19 INFO - 'read-buildbot-config', 14:11:19 INFO - 'download-and-extract', 14:11:19 INFO - 'populate-webroot', 14:11:19 INFO - 'create-virtualenv', 14:11:19 INFO - 'install', 14:11:19 INFO - 'run-tests'), 14:11:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:19 INFO - 'download_minidump_stackwalk': True, 14:11:19 INFO - 'download_symbols': 'ondemand', 14:11:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:19 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:19 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:19 INFO - 'installer_path': 'installer.exe', 14:11:19 INFO - 'log_level': 'info', 14:11:19 INFO - 'log_name': 'talos', 14:11:19 INFO - 'log_to_console': True, 14:11:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:11:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:11:19 INFO - 'opt_config_files': (), 14:11:19 INFO - 'pip_index': False, 14:11:19 INFO - 'sps_profile': False, 14:11:19 INFO - 'sps_profile_interval': 0, 14:11:19 INFO - 'suite': 'dromaeojs-e10s', 14:11:19 INFO - 'system_bits': '32', 14:11:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:19 INFO - 'title': 'talos-linux64-ix-061', 14:11:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:19 INFO - 'use_talos_json': True, 14:11:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:19 INFO - 'work_dir': 'build'} 14:11:19 INFO - ##### 14:11:19 INFO - ##### Running clobber step. 14:11:19 INFO - ##### 14:11:19 INFO - Running pre-action listener: _resource_record_pre_action 14:11:19 INFO - Running main action method: clobber 14:11:19 INFO - rmtree: /builds/slave/test/build 14:11:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:19 INFO - Running post-action listener: _resource_record_post_action 14:11:19 INFO - ##### 14:11:19 INFO - ##### Finished clobber step (success) 14:11:19 INFO - ##### 14:11:19 INFO - ##### 14:11:19 INFO - ##### Running read-buildbot-config step. 14:11:19 INFO - ##### 14:11:19 INFO - Running pre-action listener: _resource_record_pre_action 14:11:19 INFO - Running main action method: read_buildbot_config 14:11:19 INFO - Using buildbot properties: 14:11:19 INFO - { 14:11:19 INFO - "project": "", 14:11:19 INFO - "product": "firefox", 14:11:19 INFO - "script_repo_revision": "production", 14:11:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:11:19 INFO - "repository": "", 14:11:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:11:19 INFO - "buildid": "20160629113018", 14:11:19 INFO - "pgo_build": "True", 14:11:19 INFO - "basedir": "/builds/slave/test", 14:11:19 INFO - "buildnumber": 586, 14:11:19 INFO - "slavename": "talos-linux64-ix-061", 14:11:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:11:19 INFO - "platform": "ubuntu64_hw", 14:11:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:11:19 INFO - "branch": "fx-team", 14:11:19 INFO - "repo_path": "integration/fx-team", 14:11:19 INFO - "revision": "5e2a5623088f114559c36a769dbea5cab6dc1e6a", 14:11:19 INFO - "stage_platform": "linux64-pgo", 14:11:19 INFO - "builduid": "b46f1eac51e54718b5ded84d24bab64a", 14:11:19 INFO - "slavebuilddir": "test" 14:11:19 INFO - } 14:11:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:11:19 INFO - Running post-action listener: _resource_record_post_action 14:11:19 INFO - ##### 14:11:19 INFO - ##### Finished read-buildbot-config step (success) 14:11:19 INFO - ##### 14:11:19 INFO - ##### 14:11:19 INFO - ##### Running download-and-extract step. 14:11:19 INFO - ##### 14:11:19 INFO - Running pre-action listener: _resource_record_pre_action 14:11:19 INFO - Running main action method: download_and_extract 14:11:19 INFO - mkdir: /builds/slave/test/build/tests 14:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:19 INFO - https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:11:20 INFO - Downloaded 1361 bytes. 14:11:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:11:20 INFO - Using the following test package requirements: 14:11:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:11:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:11:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'jsshell-linux-x86_64.zip'], 14:11:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:11:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:11:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:11:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:11:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:11:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:20 INFO - https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:21 INFO - Downloaded 24268174 bytes. 14:11:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:11:22 INFO - Return code: 0 14:11:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:24 INFO - Downloaded 24268174 bytes. 14:11:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:11:26 INFO - Return code: 0 14:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:26 INFO - https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:11:27 INFO - Downloaded 14405245 bytes. 14:11:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:11:27 INFO - Return code: 0 14:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:27 INFO - https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:11:28 INFO - Downloaded 60329519 bytes. 14:11:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:28 INFO - mkdir: /builds/slave/test/properties 14:11:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:28 INFO - Contents: 14:11:28 INFO - build_url:https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:11:29 INFO - Running post-action listener: _resource_record_post_action 14:11:29 INFO - Running post-action listener: set_extra_try_arguments 14:11:29 INFO - ##### 14:11:29 INFO - ##### Finished download-and-extract step (success) 14:11:29 INFO - ##### 14:11:29 INFO - ##### 14:11:29 INFO - ##### Running populate-webroot step. 14:11:29 INFO - ##### 14:11:29 INFO - Running pre-action listener: _resource_record_pre_action 14:11:29 INFO - Running main action method: populate_webroot 14:11:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:29 INFO - '--tppagecycles', 14:11:29 INFO - '7'], 14:11:29 INFO - 'tests': ['tsvgm']}}, 14:11:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['damp', 'tps']}, 14:11:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'tests': ['damp', 'tps']}, 14:11:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['dromaeo_dom']}, 14:11:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['basic_compositor_video']}, 14:11:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['a11yr', 14:11:29 INFO - 'ts_paint', 14:11:29 INFO - 'tpaint', 14:11:29 INFO - 'sessionrestore', 14:11:29 INFO - 'sessionrestore_no_auto_restore', 14:11:29 INFO - 'tabpaint']}, 14:11:29 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:29 INFO - 'ts_paint', 14:11:29 INFO - 'tpaint', 14:11:29 INFO - 'sessionrestore', 14:11:29 INFO - 'sessionrestore_no_auto_restore', 14:11:29 INFO - 'tabpaint']}, 14:11:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:29 INFO - 'ts_paint', 14:11:29 INFO - 'tpaint', 14:11:29 INFO - 'sessionrestore', 14:11:29 INFO - 'sessionrestore_no_auto_restore', 14:11:29 INFO - 'tabpaint']}, 14:11:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:29 INFO - 'ts_paint', 14:11:29 INFO - 'tpaint', 14:11:29 INFO - 'sessionrestore', 14:11:29 INFO - 'sessionrestore_no_auto_restore', 14:11:29 INFO - 'tabpaint']}, 14:11:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['a11yr', 14:11:29 INFO - 'ts_paint', 14:11:29 INFO - 'tpaint', 14:11:29 INFO - 'sessionrestore', 14:11:29 INFO - 'sessionrestore_no_auto_restore', 14:11:29 INFO - 'tabpaint']}, 14:11:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['a11yr', 14:11:29 INFO - 'ts_paint', 14:11:29 INFO - 'tpaint', 14:11:29 INFO - 'sessionrestore', 14:11:29 INFO - 'sessionrestore_no_auto_restore', 14:11:29 INFO - 'tabpaint']}, 14:11:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['tsvgx', 14:11:29 INFO - 'tsvgr_opacity', 14:11:29 INFO - 'tart', 14:11:29 INFO - 'tscrollx', 14:11:29 INFO - 'cart']}, 14:11:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:29 INFO - 'tsvgr_opacity', 14:11:29 INFO - 'tart', 14:11:29 INFO - 'tscrollx', 14:11:29 INFO - 'cart']}, 14:11:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'talos_options': ['--disable-e10s'], 14:11:29 INFO - 'tests': ['tp5o']}, 14:11:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'tests': ['tp5o']}, 14:11:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'talos_options': ['--disable-e10s', 14:11:29 INFO - '--xperf_path', 14:11:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:29 INFO - 'tests': ['tp5n']}, 14:11:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:29 INFO - 'talos_options': ['--xperf_path', 14:11:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:29 INFO - 'tests': ['tp5n']}}, 14:11:29 INFO - 'talos.zip': {'path': '', 14:11:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:29 INFO - Running post-action listener: _resource_record_post_action 14:11:29 INFO - ##### 14:11:29 INFO - ##### Finished populate-webroot step (success) 14:11:29 INFO - ##### 14:11:29 INFO - ##### 14:11:29 INFO - ##### Running create-virtualenv step. 14:11:29 INFO - ##### 14:11:29 INFO - Running pre-action listener: _resource_record_pre_action 14:11:29 INFO - Running main action method: create_virtualenv 14:11:29 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:29 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 14:11:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:29 INFO - Using real prefix '/usr' 14:11:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:32 INFO - Installing pip.................done. 14:11:32 INFO - Return code: 0 14:11:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:32 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 14:11:32 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 14:11:32 INFO - Using env: {'DISPLAY': ':0', 14:11:32 INFO - 'HOME': '/home/cltbld', 14:11:32 INFO - 'LANG': 'en_US.UTF-8', 14:11:32 INFO - 'LANGUAGE': 'en_US:en', 14:11:32 INFO - 'LOGNAME': 'cltbld', 14:11:32 INFO - 'MAIL': '/var/mail/cltbld', 14:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:32 INFO - 'MOZ_NO_REMOTE': '1', 14:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:32 INFO - 'NO_EM_RESTART': '1', 14:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:32 INFO - 'PWD': '/builds/slave/test', 14:11:32 INFO - 'SHELL': '/bin/bash', 14:11:32 INFO - 'SHLVL': '1', 14:11:32 INFO - 'TERM': 'linux', 14:11:32 INFO - 'TMOUT': '86400', 14:11:32 INFO - 'USER': 'cltbld', 14:11:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:32 INFO - '_': '/tools/buildbot/bin/python'} 14:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:32 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 14:11:32 INFO - Cleaning up... 14:11:32 INFO - Return code: 0 14:11:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:32 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 14:11:32 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 14:11:32 INFO - Using env: {'DISPLAY': ':0', 14:11:32 INFO - 'HOME': '/home/cltbld', 14:11:32 INFO - 'LANG': 'en_US.UTF-8', 14:11:32 INFO - 'LANGUAGE': 'en_US:en', 14:11:32 INFO - 'LOGNAME': 'cltbld', 14:11:32 INFO - 'MAIL': '/var/mail/cltbld', 14:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:32 INFO - 'MOZ_NO_REMOTE': '1', 14:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:32 INFO - 'NO_EM_RESTART': '1', 14:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:32 INFO - 'PWD': '/builds/slave/test', 14:11:32 INFO - 'SHELL': '/bin/bash', 14:11:32 INFO - 'SHLVL': '1', 14:11:32 INFO - 'TERM': 'linux', 14:11:32 INFO - 'TMOUT': '86400', 14:11:32 INFO - 'USER': 'cltbld', 14:11:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:32 INFO - '_': '/tools/buildbot/bin/python'} 14:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:32 INFO - Downloading/unpacking psutil>=3.1.1 14:11:32 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 14:11:32 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 14:11:32 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 14:11:32 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 14:11:32 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 14:11:32 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 14:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:34 INFO - Installing collected packages: psutil 14:11:34 INFO - Running setup.py install for psutil 14:11:34 INFO - building 'psutil._psutil_linux' extension 14:11:34 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 14:11:34 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 14:11:34 INFO - building 'psutil._psutil_posix' extension 14:11:34 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 14:11:34 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 14:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:34 INFO - Successfully installed psutil 14:11:34 INFO - Cleaning up... 14:11:35 INFO - Return code: 0 14:11:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:35 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:35 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 14:11:35 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 14:11:35 INFO - Using env: {'DISPLAY': ':0', 14:11:35 INFO - 'HOME': '/home/cltbld', 14:11:35 INFO - 'LANG': 'en_US.UTF-8', 14:11:35 INFO - 'LANGUAGE': 'en_US:en', 14:11:35 INFO - 'LOGNAME': 'cltbld', 14:11:35 INFO - 'MAIL': '/var/mail/cltbld', 14:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:35 INFO - 'MOZ_NO_REMOTE': '1', 14:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:35 INFO - 'NO_EM_RESTART': '1', 14:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:35 INFO - 'PWD': '/builds/slave/test', 14:11:35 INFO - 'SHELL': '/bin/bash', 14:11:35 INFO - 'SHLVL': '1', 14:11:35 INFO - 'TERM': 'linux', 14:11:35 INFO - 'TMOUT': '86400', 14:11:35 INFO - 'USER': 'cltbld', 14:11:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:35 INFO - '_': '/tools/buildbot/bin/python'} 14:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:35 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 14:11:35 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 14:11:35 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 14:11:35 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 14:11:35 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 14:11:35 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 14:11:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:37 INFO - Installing collected packages: mozsystemmonitor 14:11:37 INFO - Running setup.py install for mozsystemmonitor 14:11:37 INFO - Successfully installed mozsystemmonitor 14:11:37 INFO - Cleaning up... 14:11:37 INFO - Return code: 0 14:11:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:37 INFO - Using env: {'DISPLAY': ':0', 14:11:37 INFO - 'HOME': '/home/cltbld', 14:11:37 INFO - 'LANG': 'en_US.UTF-8', 14:11:37 INFO - 'LANGUAGE': 'en_US:en', 14:11:37 INFO - 'LOGNAME': 'cltbld', 14:11:37 INFO - 'MAIL': '/var/mail/cltbld', 14:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:37 INFO - 'MOZ_NO_REMOTE': '1', 14:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:37 INFO - 'NO_EM_RESTART': '1', 14:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:37 INFO - 'PWD': '/builds/slave/test', 14:11:37 INFO - 'SHELL': '/bin/bash', 14:11:37 INFO - 'SHLVL': '1', 14:11:37 INFO - 'TERM': 'linux', 14:11:37 INFO - 'TMOUT': '86400', 14:11:37 INFO - 'USER': 'cltbld', 14:11:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:37 INFO - '_': '/tools/buildbot/bin/python'} 14:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:37 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:39 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 14:11:39 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 14:11:39 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 14:11:39 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 14:11:39 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 14:11:39 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 14:11:39 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:39 INFO - warning: no files found matching '*.txt' 14:11:39 INFO - no previously-included directories found matching 'build' 14:11:39 INFO - no previously-included directories found matching 'dist' 14:11:39 INFO - no previously-included directories found matching '.git*' 14:11:39 INFO - Installing collected packages: jsonschema, functools32 14:11:39 INFO - Running setup.py install for functools32 14:11:39 INFO - warning: no files found matching '*.txt' 14:11:39 INFO - no previously-included directories found matching 'build' 14:11:39 INFO - no previously-included directories found matching 'dist' 14:11:39 INFO - no previously-included directories found matching '.git*' 14:11:39 INFO - Successfully installed jsonschema functools32 14:11:39 INFO - Cleaning up... 14:11:39 INFO - Return code: 0 14:11:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:39 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 14:11:39 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 14:11:39 INFO - Using env: {'DISPLAY': ':0', 14:11:39 INFO - 'HOME': '/home/cltbld', 14:11:39 INFO - 'LANG': 'en_US.UTF-8', 14:11:39 INFO - 'LANGUAGE': 'en_US:en', 14:11:39 INFO - 'LOGNAME': 'cltbld', 14:11:39 INFO - 'MAIL': '/var/mail/cltbld', 14:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:39 INFO - 'MOZ_NO_REMOTE': '1', 14:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:39 INFO - 'NO_EM_RESTART': '1', 14:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:39 INFO - 'PWD': '/builds/slave/test', 14:11:39 INFO - 'SHELL': '/bin/bash', 14:11:39 INFO - 'SHLVL': '1', 14:11:39 INFO - 'TERM': 'linux', 14:11:39 INFO - 'TMOUT': '86400', 14:11:39 INFO - 'USER': 'cltbld', 14:11:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:39 INFO - '_': '/tools/buildbot/bin/python'} 14:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:40 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:42 INFO - Downloading docopt-0.6.1.tar.gz 14:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:42 INFO - Running setup.py install for blobuploader 14:11:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:42 INFO - Running setup.py install for requests 14:11:43 INFO - Running setup.py install for docopt 14:11:43 INFO - Successfully installed blobuploader requests docopt 14:11:43 INFO - Cleaning up... 14:11:43 INFO - Return code: 0 14:11:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:43 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:43 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 14:11:43 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 14:11:43 INFO - Using env: {'DISPLAY': ':0', 14:11:43 INFO - 'HOME': '/home/cltbld', 14:11:43 INFO - 'LANG': 'en_US.UTF-8', 14:11:43 INFO - 'LANGUAGE': 'en_US:en', 14:11:43 INFO - 'LOGNAME': 'cltbld', 14:11:43 INFO - 'MAIL': '/var/mail/cltbld', 14:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:43 INFO - 'MOZ_NO_REMOTE': '1', 14:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:43 INFO - 'NO_EM_RESTART': '1', 14:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:43 INFO - 'PWD': '/builds/slave/test', 14:11:43 INFO - 'SHELL': '/bin/bash', 14:11:43 INFO - 'SHLVL': '1', 14:11:43 INFO - 'TERM': 'linux', 14:11:43 INFO - 'TMOUT': '86400', 14:11:43 INFO - 'USER': 'cltbld', 14:11:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:43 INFO - '_': '/tools/buildbot/bin/python'} 14:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:43 INFO - Running setup.py (path:/tmp/pip-AC8UwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:43 INFO - Running setup.py (path:/tmp/pip-FcLl2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:43 INFO - Running setup.py (path:/tmp/pip-xD4utc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:43 INFO - Running setup.py (path:/tmp/pip-qGceJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:43 INFO - Running setup.py (path:/tmp/pip-JBgCi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:44 INFO - Running setup.py (path:/tmp/pip-zMKnh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:44 INFO - Running setup.py (path:/tmp/pip-Z6xYvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:44 INFO - Running setup.py (path:/tmp/pip-xLxfvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:44 INFO - Running setup.py (path:/tmp/pip-pit3Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:44 INFO - Running setup.py (path:/tmp/pip-kKPOOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:44 INFO - Running setup.py (path:/tmp/pip-JfjqfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:44 INFO - Running setup.py (path:/tmp/pip-mlt1Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:44 INFO - Running setup.py (path:/tmp/pip-5kp6Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:44 INFO - Running setup.py (path:/tmp/pip-s4pXv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:44 INFO - Running setup.py (path:/tmp/pip-HUtJdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:44 INFO - Running setup.py (path:/tmp/pip-tMYOJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:44 INFO - Running setup.py (path:/tmp/pip-e8pd8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:44 INFO - Running setup.py install for manifestparser 14:11:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Running setup.py install for mozcrash 14:11:45 INFO - Running setup.py install for mozdebug 14:11:45 INFO - Running setup.py install for mozdevice 14:11:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Running setup.py install for mozfile 14:11:45 INFO - Running setup.py install for mozhttpd 14:11:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Running setup.py install for mozinfo 14:11:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Running setup.py install for mozInstall 14:11:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Running setup.py install for mozleak 14:11:45 INFO - Running setup.py install for mozlog 14:11:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:45 INFO - Running setup.py install for moznetwork 14:11:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:46 INFO - Running setup.py install for mozprocess 14:11:46 INFO - Running setup.py install for mozprofile 14:11:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:46 INFO - Running setup.py install for mozrunner 14:11:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:46 INFO - Running setup.py install for mozscreenshot 14:11:46 INFO - Running setup.py install for moztest 14:11:46 INFO - Running setup.py install for mozversion 14:11:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:46 INFO - Cleaning up... 14:11:46 INFO - Return code: 0 14:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:46 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:46 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 14:11:46 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 14:11:46 INFO - Using env: {'DISPLAY': ':0', 14:11:46 INFO - 'HOME': '/home/cltbld', 14:11:46 INFO - 'LANG': 'en_US.UTF-8', 14:11:46 INFO - 'LANGUAGE': 'en_US:en', 14:11:46 INFO - 'LOGNAME': 'cltbld', 14:11:46 INFO - 'MAIL': '/var/mail/cltbld', 14:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:46 INFO - 'MOZ_NO_REMOTE': '1', 14:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:46 INFO - 'NO_EM_RESTART': '1', 14:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:46 INFO - 'PWD': '/builds/slave/test', 14:11:46 INFO - 'SHELL': '/bin/bash', 14:11:46 INFO - 'SHLVL': '1', 14:11:46 INFO - 'TERM': 'linux', 14:11:46 INFO - 'TMOUT': '86400', 14:11:46 INFO - 'USER': 'cltbld', 14:11:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:46 INFO - '_': '/tools/buildbot/bin/python'} 14:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:46 INFO - Running setup.py (path:/tmp/pip-iCvxrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:46 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)) 14:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:46 INFO - Running setup.py (path:/tmp/pip-VOJDlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:47 INFO - Running setup.py (path:/tmp/pip-I080pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:47 INFO - Running setup.py (path:/tmp/pip-a7PNp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:47 INFO - Running setup.py (path:/tmp/pip-VZY2uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:47 INFO - Running setup.py (path:/tmp/pip-OG5Uco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:47 INFO - Running setup.py (path:/tmp/pip-IRbh3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:47 INFO - Running setup.py (path:/tmp/pip-53T7RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:47 INFO - Running setup.py (path:/tmp/pip-i1bOEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:47 INFO - Running setup.py (path:/tmp/pip-VbCzaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:47 INFO - Running setup.py (path:/tmp/pip-Fdgy5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:47 INFO - Running setup.py (path:/tmp/pip-nBEpJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:47 INFO - Running setup.py (path:/tmp/pip-_4ZR_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:47 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:47 INFO - Running setup.py (path:/tmp/pip-tVhtTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:47 INFO - Running setup.py (path:/tmp/pip-pYdnuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:48 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)) 14:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:48 INFO - Running setup.py (path:/tmp/pip-YMXi3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:48 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)) 14:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:48 INFO - Running setup.py (path:/tmp/pip-_CbXBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:48 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)) 14:11:48 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)) 14:11:48 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)) 14:11:48 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)) 14:11:48 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)) 14:11:48 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)) 14:11:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:50 INFO - Downloading blessings-1.6.tar.gz 14:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:50 INFO - Installing collected packages: blessings 14:11:50 INFO - Running setup.py install for blessings 14:11:50 INFO - Successfully installed blessings 14:11:50 INFO - Cleaning up... 14:11:50 INFO - Return code: 0 14:11:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:50 INFO - Reading from file tmpfile_stdout 14:11:50 INFO - Current package versions: 14:11:50 INFO - argparse == 1.2.1 14:11:50 INFO - blessings == 1.6 14:11:50 INFO - blobuploader == 1.2.4 14:11:50 INFO - docopt == 0.6.1 14:11:50 INFO - functools32 == 3.2.3-2 14:11:50 INFO - jsonschema == 2.5.1 14:11:50 INFO - manifestparser == 1.1 14:11:50 INFO - mozInstall == 1.12 14:11:50 INFO - mozcrash == 0.17 14:11:50 INFO - mozdebug == 0.1 14:11:50 INFO - mozdevice == 0.48 14:11:50 INFO - mozfile == 1.2 14:11:50 INFO - mozhttpd == 0.7 14:11:50 INFO - mozinfo == 0.9 14:11:50 INFO - mozleak == 0.1 14:11:50 INFO - mozlog == 3.2 14:11:50 INFO - moznetwork == 0.27 14:11:50 INFO - mozprocess == 0.22 14:11:50 INFO - mozprofile == 0.28 14:11:50 INFO - mozrunner == 6.11 14:11:50 INFO - mozscreenshot == 0.1 14:11:50 INFO - mozsystemmonitor == 0.3 14:11:50 INFO - moztest == 0.7 14:11:50 INFO - mozversion == 1.4 14:11:50 INFO - psutil == 3.1.1 14:11:50 INFO - requests == 1.2.3 14:11:50 INFO - wsgiref == 0.1.2 14:11:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:50 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:50 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 14:11:50 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 14:11:50 INFO - Using env: {'DISPLAY': ':0', 14:11:50 INFO - 'HOME': '/home/cltbld', 14:11:50 INFO - 'LANG': 'en_US.UTF-8', 14:11:50 INFO - 'LANGUAGE': 'en_US:en', 14:11:50 INFO - 'LOGNAME': 'cltbld', 14:11:50 INFO - 'MAIL': '/var/mail/cltbld', 14:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:50 INFO - 'MOZ_NO_REMOTE': '1', 14:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:50 INFO - 'NO_EM_RESTART': '1', 14:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:50 INFO - 'PWD': '/builds/slave/test', 14:11:50 INFO - 'SHELL': '/bin/bash', 14:11:50 INFO - 'SHLVL': '1', 14:11:50 INFO - 'TERM': 'linux', 14:11:50 INFO - 'TMOUT': '86400', 14:11:50 INFO - 'USER': 'cltbld', 14:11:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:50 INFO - '_': '/tools/buildbot/bin/python'} 14:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 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)) 14:11:50 INFO - Cleaning up... 14:11:50 INFO - Return code: 0 14:11:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:50 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 0x28c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b86180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', '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 14:11:50 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 14:11:50 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 14:11:50 INFO - Using env: {'DISPLAY': ':0', 14:11:50 INFO - 'HOME': '/home/cltbld', 14:11:50 INFO - 'LANG': 'en_US.UTF-8', 14:11:50 INFO - 'LANGUAGE': 'en_US:en', 14:11:50 INFO - 'LOGNAME': 'cltbld', 14:11:50 INFO - 'MAIL': '/var/mail/cltbld', 14:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:50 INFO - 'MOZ_NO_REMOTE': '1', 14:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:50 INFO - 'NO_EM_RESTART': '1', 14:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:50 INFO - 'PWD': '/builds/slave/test', 14:11:50 INFO - 'SHELL': '/bin/bash', 14:11:50 INFO - 'SHLVL': '1', 14:11:50 INFO - 'TERM': 'linux', 14:11:50 INFO - 'TMOUT': '86400', 14:11:50 INFO - 'USER': 'cltbld', 14:11:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:50 INFO - '_': '/tools/buildbot/bin/python'} 14:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:50 INFO - Cleaning up... 14:11:50 INFO - Return code: 0 14:11:50 INFO - Running post-action listener: _resource_record_post_action 14:11:50 INFO - Running post-action listener: _start_resource_monitoring 14:11:50 INFO - Starting resource monitoring. 14:11:50 INFO - ##### 14:11:50 INFO - ##### Finished create-virtualenv step (success) 14:11:50 INFO - ##### 14:11:50 INFO - ##### 14:11:50 INFO - ##### Running install step. 14:11:50 INFO - ##### 14:11:50 INFO - Running pre-action listener: _resource_record_pre_action 14:11:50 INFO - Running main action method: install 14:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:51 INFO - Reading from file tmpfile_stdout 14:11:51 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:51 INFO - Reading from file tmpfile_stdout 14:11:51 INFO - Output received: 14:11:51 INFO - Usage: mozinstall [options] installer 14:11:51 INFO - Options: 14:11:51 INFO - -h, --help show this help message and exit 14:11:51 INFO - -d DEST, --destination=DEST 14:11:51 INFO - Directory to install application into. [default: 14:11:51 INFO - "/builds/slave/test"] 14:11:51 INFO - --app=APP Application being installed. [default: firefox] 14:11:51 INFO - mkdir: /builds/slave/test/build/application 14:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:12:09 INFO - Reading from file tmpfile_stdout 14:12:09 INFO - Output received: 14:12:09 INFO - /builds/slave/test/build/application/firefox/firefox 14:12:09 INFO - Running post-action listener: _resource_record_post_action 14:12:09 INFO - ##### 14:12:09 INFO - ##### Finished install step (success) 14:12:09 INFO - ##### 14:12:09 INFO - ##### 14:12:09 INFO - ##### Running run-tests step. 14:12:09 INFO - ##### 14:12:09 INFO - Running pre-action listener: _resource_record_pre_action 14:12:09 INFO - Running main action method: run_tests 14:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:09 INFO - Python 2.7.3 14:12:09 INFO - Return code: 0 14:12:09 INFO - grabbing minidump binary from tooltool 14:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:09 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 0x2b843b0>, '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 0x2b852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b85740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:09 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 14:12:09 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 14:12:09 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 14:12:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:09 INFO - Return code: 0 14:12:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:12:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:12:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:09 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/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 14:12:09 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/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 14:12:09 INFO - Using env: {'DISPLAY': ':0', 14:12:09 INFO - 'HOME': '/home/cltbld', 14:12:09 INFO - 'LANG': 'en_US.UTF-8', 14:12:09 INFO - 'LANGUAGE': 'en_US:en', 14:12:09 INFO - 'LOGNAME': 'cltbld', 14:12:09 INFO - 'MAIL': '/var/mail/cltbld', 14:12:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:09 INFO - 'MOZ_NO_REMOTE': '1', 14:12:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:09 INFO - 'NO_EM_RESTART': '1', 14:12:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:09 INFO - 'PWD': '/builds/slave/test', 14:12:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:09 INFO - 'SHELL': '/bin/bash', 14:12:09 INFO - 'SHLVL': '1', 14:12:09 INFO - 'TERM': 'linux', 14:12:09 INFO - 'TMOUT': '86400', 14:12:09 INFO - 'USER': 'cltbld', 14:12:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488', 14:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:09 INFO - '_': '/tools/buildbot/bin/python'} 14:12:09 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/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 14:12:09 INFO - mozversion application_buildid: 20160629113018 14:12:09 INFO - mozversion application_changeset: 5e2a5623088f114559c36a769dbea5cab6dc1e6a 14:12:09 INFO - mozversion application_display_name: Nightly 14:12:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:09 INFO - mozversion application_name: Firefox 14:12:09 INFO - mozversion application_remotingname: firefox 14:12:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:12:09 INFO - mozversion application_vendor: Mozilla 14:12:09 INFO - mozversion application_version: 50.0a1 14:12:09 INFO - mozversion platform_buildid: 20160629113018 14:12:09 INFO - mozversion platform_changeset: 5e2a5623088f114559c36a769dbea5cab6dc1e6a 14:12:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:12:09 INFO - mozversion platform_version: 50.0a1 14:12:09 INFO - using testdate: 1467234729 14:12:09 INFO - actual date: 1467234729 14:12:09 INFO - starting webserver on 'localhost:41812' 14:12:09 INFO - SUITE-START | Running 2 tests 14:12:09 INFO - TEST-START | dromaeo_css 14:12:09 INFO - operating with platform_type : linux_ 14:12:09 INFO - Initialising browser for dromaeo_css test... 14:12:09 INFO - TEST-INFO | started process 15809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiAnLdN/profile http://localhost:41812/getInfo.html) 14:12:14 INFO - PROCESS | 15809 | __metrics Screen width/height:1600/1200 14:12:14 INFO - PROCESS | 15809 | colorDepth:24 14:12:14 INFO - PROCESS | 15809 | Browser inner width/height: 1024/697 14:12:14 INFO - PROCESS | 15809 | __metrics 14:12:15 ERROR - PROCESS | 15809 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:12:15 INFO - TEST-INFO | 15809: exit 0 14:12:15 INFO - Browser initialized. 14:12:15 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:15 INFO - TEST-INFO | started process 15931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiAnLdN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:27 INFO - PROCESS | 15931 | RSS: Main: 168468480 14:12:27 INFO - PROCESS | 15931 | 14:13:17 INFO - PROCESS | 15931 | 1467234797230 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] 14:15:25 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:41812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41812/tests/dromaeo/cssquery-ext.html) 14:15:26 INFO - PROCESS | 15931 | RSS: Main: 171335680 14:15:26 INFO - PROCESS | 15931 | 14:18:28 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:41812/tests/dromaeo/cssquery-ext.html (next: http://localhost:41812/tests/dromaeo/cssquery-jquery.html) 14:18:29 INFO - PROCESS | 15931 | RSS: Main: 168755200 14:18:29 INFO - PROCESS | 15931 | 14:21:31 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:41812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41812/tests/dromaeo/cssquery-mootools.html) 14:21:31 INFO - PROCESS | 15931 | RSS: Main: 172396544 14:21:31 INFO - PROCESS | 15931 | 14:24:33 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:41812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41812/tests/dromaeo/cssquery-prototype.html) 14:24:34 INFO - PROCESS | 15931 | RSS: Main: 167641088 14:24:34 INFO - PROCESS | 15931 | 14:27:36 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:41812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41812/tests/dromaeo/cssquery-yui.html) 14:27:37 INFO - PROCESS | 15931 | RSS: Main: 169570304 14:27:37 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:41812/tests/dromaeo/cssquery-yui.html (next: http://localhost:41812/tests/dromaeo/cssquery-dojo.html) 14:30:39 INFO - PROCESS | 15931 | RSS: Main: 170942464 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | __start_tp_report 14:30:39 INFO - PROCESS | 15931 | _x_x_mozilla_page_load 14:30:39 INFO - PROCESS | 15931 | _x_x_mozilla_page_load_details 14:30:39 INFO - PROCESS | 15931 | |i|pagename|runs| 14:30:39 INFO - PROCESS | 15931 | |0;dojo.html;3070.787039119548;3118.267207206307;3129.3428380040205;3163.098516922676;3163.841807909604;5375.9193612095805;5390.1375779875225;5429.185622156673;5448.318960129984;5534.142207957763;5348.652337598053;5396.703181325026;5439.945600543993;5484.369297530775;5506.614536982403;4885.755712214393;4923.458419573844;4984.576311013569;5061.6962982221;5079.161938280179;4910.386201724785;5134.435212126663;5165.431802501722;5176.922346164811;5194.506521880416;4843.225083986563;4880.902381952376;4888.315635810989;4915.729634870081;4916.852494425138;4939.827106051271;4955.1080805455;4959.380077490314;4959.603231741488;4998.125328067574;4885.902281954341;4918.532739389752;4924.852254432372;4950.67820591664;4954.677945933503;5257.369115706101;5344.91982620261;5352.759125839308;5430.429804870471;5444.183372494118;5849.912251316234;5860.706964651793;5861.6189947653265;5861.765529378819;5862.179294898718;5737.39757325479;5891.381404952461;5894.469497745224;5897.233359663216;5901.262342207224;5403.594730395236;5432.185172224158;5460.672359658433;5523.337199536041;5531.723413829292;5954;5972.761089556456;5977.641341519523;5978.491828194652;5983.611065280743;5485.369182543979;5746.482816546447;5789.652620842763;5792.9710351447975;5795.768169273182;5675.432456754292;5736.42635736423;5748.02283611787;5821.359650438449;5843.094320380348;5556.249906262684;5748.45389687979;5782.624129431573;5794.536437085023;5818.33089194748;5629.887402251932;5799.855003624859;5839.737211825478;5859.707014649336;5871.089981052858;4410.823567057346;4455.331700244989;4462.219111655448;4463.486699029589;4468.754218517947;3984.5019372578427;3993.6405723485027;4013.5986401360215;4019.2765302245293;4021.155557332934;5536.861578460571;5537.501624853782;5636.18275350072;5654.660720356709;5673.517750991212;5867.765289388462;5869.647821130746;5880.382559831241;5902.763889444374;5922.644641321534;5536.335639723259;5547.362053363834;5555.194496798023;5557.44425557441;5573.414791446839;4968.701877887338;4971.353724015927;5003.4746351633285;5021.84934451967;5040.899182016339;5945.316288626776;5948;5979.880402391927;5991.670458124758;6009.519238460913;5653.462921022497;5828.067509198508;5835.066389377764;5848.327442344185;5850.53195744348;5978.551608629457;5987.670678112746;6025.969870150621;6048.304444988883;6059.878802423838;5788.710564471844;5789.91315130265;5790.420957904176;5807.535397168301;5809.535237180931;5667.943320566907;5745.396733343106;5898.1152827076285;5900.468957793819;5903.173555702119;5623.128415095667;5689.687067211343;5690.971545142248;5692.658440493584;5754.194412782297;5538.556915446835;5601.971990140023;5655.406182350958;5659.518940890071;5686.60193786431;5556.666600004012;5620.85947851307;5621.52217061538;5624.578156638187;5631.436856314336;5549.195366671891;5557.305336832896;5651.406602306699;5684.090545512699;5768.307803063659;5539.196816461671;5575.219469274224;5588.720563971867;5595.964746521907;5601.747921343631 14:30:39 INFO - PROCESS | 15931 | |1;ext.html;596.9731362088705;599.1312596734734;624.9750009999598;628.1990462160746;673.6025744810561;38420.23159536807;41626.58373416265;42173.78913105438;42359.36460953084;42473;42368.36447453291;42401.575984240146;42545;42600;42650.360244596355;8820.603072861704;9025.684101056464;9025.909740902605;9028.458292502439;9031.95484022579;8877.067907869678;8958.059403762609;8962.283017358628;8963.865542016874;8966.730998070036;8877.334199934998;8921.152490513423;8990.910090899106;9005.909940900605;9008.68469603564;8874.20132188103;8878.511681857495;8883;8927.955360223157;8968.50673212973;8857.291416686714;8929.73210803677;8955.641774329084;8968.551572421418;9000.414973026798;34255;41493.37759933603;41891;41988.79005604983;41993.79003104995;3474.096734848932;3498.405271103893;3609.530761001079;3706.5181526401666;3748.19413826026;31776.205594860083;32256.35487290241;32339.6766032339;32561.023169304957;33736;4177.185448837478;4201.6008479194425;4252.936205956913;4275.187714334266;4334.674899382559;321582;323004;323263;324077;324990;36354.636453635656;37275.440868387;37723.434148487795;37831.81084094617;37929.81035094807;37030.44454333187;38942.80528597339;38982.6101738979;39262.411063834064;39311;14607.561773146823;14800.777988330183;14835.703285934436;14838.554843354717;14863.405463781544;13240.801387979189;13332.800007999887;13397;13397.799033014513;13453.798193027113;8983.685571005115;9004.954975225213;9019.954900225588;9028.413153145024;9037.277017838556;3381.188514756441;3395.3548825723033;3422.9486557701653;3426.378820202547;3491.9825400872833;1031.7626945802508;1119.2724728926264;1125.5047778977387;1134.1153899958047;1183.1126655008743;31647;32391.51412728811;32979.83510082434;33149.83425082859;34019.319613607586;1078.741102135482;1115.6485707002269;1130.4743294368159;1151.2862025544216;1227.3372378915465;16604;16619.584510387096;16723.49829505117;16834.915825421038;17094.316227351017;602108;605329;611009;611591;613359;59779.40220597825;60551.09173362403;60588.39411605916;60819;60846.69576652177;1370.7327071221216;1372.7803551431723;1382.5644921849787;1398.3637444962314;1431.8854491640643;31183.84408077945;31532.211694707818;31720.77954543252;31890;32780.50829237611;52322;52923.47076529185;53271.73364133154;53419;53494.46505534895;471231;477495;482419;482697;484257;30009;30093.849530752206;30279.09162725122;30286.69713302839;30331.848340758155;50166.74916625393;50490.747546263505;50754.74622626863;51448.22827657513;51475.742621286656;42980.57019429891;43470.347944780224;43959.340609890234;43981;44943.55056449393;42332;43390.34914476349;43450.348244776986;44176.11647767091;44282.77858610686;35460;41153.1769364617;41218.58781412148;41479.37780933228;42613.36079958865;37689.43465847959;38206.235875282895;38419.42370864495;38547.229055418175;39005.41491877567;25032.200313300636;25451.87274063618;25477.872610636827;25480.74519254858;26042 14:30:39 INFO - PROCESS | 15931 | |2;jquery.html;399.1438364707704;401.8613578315482;410.27791087685665;410.90343769214235;421.7132350001999;18569.81430185698;20409.795902040976;20431.080601372956;21029.474263143427;21129.894350528266;19324;19477.707834382494;20162.39512814614;20228;20323.898380508115;5721.199032135504;5922.763089476416;5956.493698035672;5982.73077711504;6001.969990150065;5433.75023744539;5844.853878653025;5870.060790273557;5907.5864689471755;5917.112433135021;5720.256366672327;5750.568707346965;5781.797637082703;5811.331696854852;5817.185594016841;5687.289088863892;5731.656100633954;5846.590738648296;5868.735906884201;5870.295564532241;5706.087026075808;5707.3721890592005;5717.342505611867;5747.59766816323;5776.162456443834;23394.532109357886;23823.523529529484;24218.757812422;24424.26727198169;24489;2241.3276017194776;2305.3775480620307;2401.483681008574;2420.987895060531;2890.942181156386;9784.55969481375;10229.283950123494;10257.487125643762;10279.948600257025;10575.682729518127;1884.1615481110912;1897.7438045863769;1919.3378284491828;1938.370029740326;1981.455099847539;79877.60061199658;80836.99999999942;80964.19035809625;85266.14733852644;87404;10821.242513024014;11426.828597571042;11560.132990025782;11733.4133293335;11779.941100294614;16148.192590370434;16318.836811631732;16342.101184434732;16369.91815040941;16374.181290935405;8229.25936665703;8461.492310461392;8513.574321284035;8526.10475900034;8629.956850215834;8082.636281367352;8101.554414507259;8136.0643525995265;8248.216419440143;8321;4663.510331415153;4709.222978208557;4762.904741905212;4781.330613714083;4815.109204797123;2033.3391647714552;2056.3008577083865;2083;2084.989575052115;2106.599746048246;949.8432758594754;976.1751320134475;994.7314225159166;1004.9648262310784;1054.9819424255477;18045.548861278312;19324.80675193258;19658;19789.113650938754;19964.90017549932;982.5332966840693;1006.2302338710892;1029.994850025745;1039.0492699180315;1063.9361638301727;10659.680209593569;10887.727806804893;10986.230963832455;11053.834192487118;11057.336559806437;173841;174211;371129;466788;472376;87776;89521;89922.55038724764;91068;91619.08380916239;960.4573416019927;964.0455948610964;970.6214576315243;982.7837875667485;1030.1398332392537;17300.567485812957;17384;17528;17554;17758.556036099202;43027;43073.569264306956;43813.78093109514;44880.10239795251;44931.77534112309;60643.39356606554;61036;61494;61737;61998;8748.825023499367;8852.468851868909;8853.73438796837;8898.688545900863;8949.373543852129;10085.495725213857;13992.16047037181;14054.437822486985;14110.435582576582;14365.784513232518;12094.39528023613;12138.271703697454;12268.570600028956;12300.200486968319;12382.133250672367;9456.952715236379;12070.27578345302;12082.939585302369;12147.514099435924;12245.87754122483;12244.571439999558;12320.630381088582;12474.376281186085;12511.4369853355;12584.18202816814;7256.564606123649;8700.869486957574;8955.552222388986;8965.551722413722;9300.255979521757;9754.268429867647;12057.939710301393;12214.816777748163;12255.816162757388;12617.116801823784 14:30:39 INFO - PROCESS | 15931 | |3;mootools.html;1479.8224213094427;1488.9478868239612;1623.9188040597967;1765.6733504301696;1776.3960253513803;7405.148407933089;8004.879926801095;8130.837383252347;8584.055753867078;8595.355348348876;8195.42632015759;8549.529775862326;8577.785555361104;8581.871271930926;8607.354448416363;2304.5966955782756;2330.720313562375;2338.3452633262714;2339.4502291961376;2344.8944797484155;2348.4833336665906;2356.7996720278798;2375.6911601491784;2378.7502312257225;2380.9880950595225;2337.123578658003;2346.9295921122393;2362.6574146748712;2369.9052037918464;2378.7740164684415;2292.6561015847587;2294.1740973249616;2297.8621282723007;2300.137448456837;2344.788968992799;2275.9544809103727;2276.5674521840797;2281.087564974007;2283.1095872609694;2289.1644549739226;8483.703070392568;8563.743087707378;8581.742547723577;8587.184217499327;8621.956890215508;5079.238114282887;5193.662411943212;5205.011047900886;5206.167013277895;5207.297014902978;3212.421764082464;3326.963472256185;3400.60892997306;3416.1630400551776;3419.111031131899;1170.9473073711704;1185.9229150105216;1191.9642410727693;1200.9699757506132;1208.576998050684;11694.883051169465;11848.822267665992;11874.346910919896;11886.405679716067;11890.108241881893;4275.593818587229;4439.955600443955;4509.759816050547;4612.446506419251;4614.192516309632;9958.651447199314;9971.10260076582;10029.598816047277;10034.69895903124;10077.29458937882;5049.697018178847;5074.162763144113;5076.873078173001;5078.314427552307;5082.983403319351;4221.598948099987;4647.512011238839;4674.69614475058;4760.928586071212;4807.591354734886;3983.960160398417;3996.300647386696;4030.1738143680477;4104.056067104582;4120.835166593362;1277.8147168660491;1312.7308901675324;1326.5091915991145;1337.2511393619604;1338.444545513601;799.3405440511485;875.9605817738217;876.6142897125244;936.2884208001967;972.9854052189223;5770.971145144247;5882.264716910387;5929.673867937305;5952.642841429441;6133.693315334215;452.39605127155613;457.81458509303786;470.06457150270717;473.3396911308705;480.6419217682849;4106.876793696194;4227.3447615619625;4229.281022226229;4236.639885609758;4262.126264115849;10078.546465409074;10411.219158562986;10525.736856578493;10531;10543.525541350658;10402.5838966442;10411.94794026025;10455.16358691303;10481.580736770444;10487.528061237263;7999.640016199285;8057.798555036054;8062.274395304451;8067.959660201662;8080.515169089874;5865.178874957424;6057.666828324484;6066.7269972850445;6221.844453888689;6257.217847769029;9684.51577421112;9719.465429401167;9762.267829912644;9875.950620246853;9895;9653.324267301221;9892.258080643836;10043.096121349114;10097.394156350643;10153.746156346151;7469.850602988018;7545;7707.421943354158;7720.073591169095;7741.148473668005;8123.431359804993;8205.95897020511;8265.173482651686;8268.37987150954;8281.54451505173;7522.811929701801;7621.542707437571;7756.650950707344;7795.961020194863;7809.570473624005;7296.7810965671115;7347.632618369167;7359.77920662381;7395.7041718330665;7465.029546158965;6986.196587392515;7031;7074.787756367317;7083.362497375055;7109.075820143348;5222.7910883565755;5233.659812112201;5305.151175811851;5383.434739352469;5407.594430417813;5086.847394578169;5129.102407078672;5221.686698798084;5321.707306098202;5358.678479291255 14:30:39 INFO - PROCESS | 15931 | |4;prototype.html;343.5568117128904;347.96694314040155;351.8152969690912;356.6540455757914;356.77166613367433;5701.74342154603;5719.6854173020465;5723.828285151441;5746.7413966371505;5758.395368486301;5662.320521537411;5666.971665141668;5693.516051135658;5703.714814259291;5705.714714264291;4006.3189257826093;4418.293073108303;4435.933460998088;4451.577100175495;4455.663301009684;4458.433253397286;4461.821527138911;4510.488986189631;4510.706804057726;4515.932261016071;4450.310201918708;4458.063806600601;4466.665000124987;4490.124425736983;4490.685652004361;4323.286657701476;4433.202023635744;4453.309736990772;4466.57567531084;4483.14820184164;3999.300122478555;4002.8598999035185;4005.9584508027833;4016.116454380032;4024.3158663027357;5507.697076660782;5528.926652505311;5555.222388805597;5555.666660000413;5577.52591029763;5045.243213517965;5099.643024988252;5101.51535604117;5142.151544995071;5142.408623008365;5880.5883588148845;5881.14723365114;5918.319393269786;5947.947957954499;5962.522998160181;4383.978080109611;4390.1878152541885;4416.763306274216;4424.668149888771;4435.3125265583885;5861.765529378819;6109.816705498843;6114.807612515561;6117.632942023492;6180.969095154495;4266.573342665709;4280.978595107004;4292.098659281586;4307.5139077018375;4310.568943105664;4352.455943007124;4354.738715677069;4355.7822108894425;4358.3244597087505;4365.519792822787;4771.665983381199;5005.1491246488185;5008.774605142778;5009.296839074659;5024.924626130611;5973.432523910222;5985.34161242263;6026.939730602638;6046.3349031606485;6068.393160683896;1508.894377393594;1514.9394024239127;1521.37623574334;1549.1944189021647;1557.766335049729;959.8560215967522;1018.7860549284733;1044.7649278912183;1049.2130901823632;1054.5096530113533;5666.206731057655;5670.858228544237;5674.858128546819;5718.51392631631;5762.366139724627;6043.214382130383;6110.877782444326;6141.293751218578;6155.138280640714;6166.537509686791;5506.504414602625;5742.483176514133;5751.5333589935135;5766.261026012694;5785.652860828363;3259.788113772597;3259.9348013039607;3265.591801024872;3277.4592192288005;3280.852361643684;6038.516918646497;6245.5628106033055;6260.561760676709;6386.094327081167;6410.903836442457;6385.616862988236;6392.584482008655;6404.263509696445;6410.935890641127;6414.390632889868;6164.845878852975;6395.680215989182;6397.744090236339;6419.325970773095;6433.806985790434;6143.600665956698;6160.291566469913;6165.907511387243;6194.132821405097;6227.657478838707;6127.509799215963;6128.938710612837;6131.84670383244;6179.969100154471;6189.226346706661;6150.938490615036;6323.20959880015;6373.490120790419;6393.680315984275;6398.808035758934;4337.284348082531;4419.29857005049;4423.469183697976;4425.6238219751685;4464.352668863062;5911.576253735948;6221.782237621662;6234.3453937337745;6253.43664083979;6276.560640755103;5987.042073268256;6034.461212390987;6037;6068.575199735976;6074.939250607437;5965.6718880461995;5976.491998180203;6015.308239552507;6024.759009639565;6049.637021778707;5603.823197128486;5744.712764361849;5950.732217050157;5968.612040217372;5973.761049557969;6098.68878191191;6103.725332359965;6107.480864126599;6132.233470816148;6134.846628834136;5621.718914054362;5921.61509501881;5948.234071156933;5973.402659734165;6001.309849367379 14:30:39 INFO - PROCESS | 15931 | |5;yui.html;781.4256521456729;786.52808315011;831.0484495252933;850.1498501498503;876.6975393489244;14285.642858928519;14689;15077.92461037696;15101;15106.773398399006;14929.328180231889;14985.475508357209;15012.924935375335;15013.62465938352;15160.317785699643;661.110805965975;780.0717146595533;794.7496538590354;801.9238172373615;802.879568064792;796.0924546017544;798.2217338095369;801.286854699318;805.243071512779;807.2855522862279;827.0199813221321;829.5810615639094;834.4951304460775;837.1210229259253;840.1808236968936;826.0252901576138;834.1158372125536;835.3275613131427;835.4402550291319;837.539353355658;616.9727403872547;617.7776000639766;618.8886000519905;619.1084837833505;619.5013014523307;14272.14367137975;14351.569452916428;14382.856171438256;14387.136771793726;14410.423583056665;13856.93071534646;13970.93014534931;14055.578332650037;15796.447124350707;15796.842031579767;13187;13190.472381104744;13274.137181083295;13294.800577991338;13459.865401346056;4432.844850430251;4477.529859364785;4478.619317357996;4491.955080449186;4562.5665561771575;75657.24342756612;80907.5954620229;81894.18105818985;81974.59012704898;83277.99999999939;11603.825942610867;11623.12826538013;11688.123390745557;11823.822642660367;11846.881531184577;20337.593248134956;20548.79451205499;20560.897195513928;20571.794282056988;21036.158553657988;8602.268807151462;8640.654373825102;8670.86993695095;8695.130486951255;8838.0621212348;4749.501302363271;4777.283407488904;4783.545563171493;4885.267209918541;4907.631927605444;3247.269364392993;3351.765376423627;3367.562216911786;3376.5272861799367;3380.560527131506;556.9832905012856;561.4834352395806;569.7066011004337;570.9371969083397;573.1517354315636;682.5938566552893;691.8305015271291;695.1102588686489;729.8686236477484;738.3502517784316;8808.911910880937;9192.17270445663;9246.537673116318;9255.167034966886;9638.95180524107;593.5014587746227;610.6427739772283;695.5617960684737;712.3197346534048;748.8614606297853;4560.5211452796975;4580.885477863014;4699.812007519729;4700.88247793801;4705.717656940595;68686;70341.29658703449;113715;117976;118402;99426;101414.49292753637;102320;102658;103905.48047259715;75757;76991.23008769953;77713;87971.68042479368;89244.9999999987;9595.856062159213;9926.900730992886;9958.950205249217;9960.651377201762;10131.848022279524;52901.47098529119;53203.733981329846;53319;54104.458955409944;54628;66636.33363666301;67700;68099.31900681127;74405.62797186196;76310.6184469074;13315.66710832237;14004.579862604138;14008.649783755487;14193.645158871112;14345.928270358581;15541.689166216838;15581.376744930076;15617.375304987674;15965.760513592537;16610.916945415196;13862.514811981533;14235.234226050881;14592.416303347747;14765.926170369079;14921.850781492047;13787.862121378657;14113.858861411254;14203.218822964836;14217.431302748188;14248.145111293356;12324.445399956845;12502.374881255719;12542.811857822322;14233.857661423668;14985.550433487013;11426.600068997544;11762.70593235176;11785.528578856749;11837.82243266369;11905.464254108412;10937.507812148313;11873.168878178445;11982.161248712506;12043.638690839289;12230.449629766505 14:30:39 INFO - PROCESS | 15931 | __end_tp_report 14:30:39 INFO - PROCESS | 15931 | __start_cc_report 14:30:39 INFO - PROCESS | 15931 | _x_x_mozilla_cycle_collect,362 14:30:39 INFO - PROCESS | 15931 | __end_cc_report 14:30:39 INFO - PROCESS | 15931 | __startTimestamp1467235839807__endTimestamp 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | ------- Summary: start ------- 14:30:39 INFO - PROCESS | 15931 | Number of tests: 6 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | [#0] dojo.html Cycles:165 Average:5409.75 Median:5601.75 stddev:611.28 (10.9%) stddev-sans-first:584.96 14:30:39 INFO - PROCESS | 15931 | Values: 3070.8 3118.3 3129.3 3163.1 3163.8 5375.9 5390.1 5429.2 5448.3 5534.1 5348.7 5396.7 5439.9 5484.4 5506.6 4885.8 4923.5 4984.6 5061.7 5079.2 4910.4 5134.4 5165.4 5176.9 5194.5 4843.2 4880.9 4888.3 4915.7 4916.9 4939.8 4955.1 4959.4 4959.6 4998.1 4885.9 4918.5 4924.9 4950.7 4954.7 5257.4 5344.9 5352.8 5430.4 5444.2 5849.9 5860.7 5861.6 5861.8 5862.2 5737.4 5891.4 5894.5 5897.2 5901.3 5403.6 5432.2 5460.7 5523.3 5531.7 5954.0 5972.8 5977.6 5978.5 5983.6 5485.4 5746.5 5789.7 5793.0 5795.8 5675.4 5736.4 5748.0 5821.4 5843.1 5556.2 5748.5 5782.6 5794.5 5818.3 5629.9 5799.9 5839.7 5859.7 5871.1 4410.8 4455.3 4462.2 4463.5 4468.8 3984.5 3993.6 4013.6 4019.3 4021.2 5536.9 5537.5 5636.2 5654.7 5673.5 5867.8 5869.6 5880.4 5902.8 5922.6 5536.3 5547.4 5555.2 5557.4 5573.4 4968.7 4971.4 5003.5 5021.8 5040.9 5945.3 5948.0 5979.9 5991.7 6009.5 5653.5 5828.1 5835.1 5848.3 5850.5 5978.6 5987.7 6026.0 6048.3 6059.9 5788.7 5789.9 5790.4 5807.5 5809.5 5667.9 5745.4 5898.1 5900.5 5903.2 5623.1 5689.7 5691.0 5692.7 5754.2 5538.6 5602.0 5655.4 5659.5 5686.6 5556.7 5620.9 5621.5 5624.6 5631.4 5549.2 5557.3 5651.4 5684.1 5768.3 5539.2 5575.2 5588.7 5596.0 5601.7 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | [#1] ext.html Cycles:180 Average:61383.64 Median:41486.38 stddev:129403.11 (311.9%) stddev-sans-first:129685.64 14:30:39 INFO - PROCESS | 15931 | Values: 597.0 599.1 625.0 628.2 673.6 38420.2 41626.6 42173.8 42359.4 42473.0 42368.4 42401.6 42545.0 42600.0 42650.4 8820.6 9025.7 9025.9 9028.5 9032.0 8877.1 8958.1 8962.3 8963.9 8966.7 8877.3 8921.2 8990.9 9005.9 9008.7 8874.2 8878.5 8883.0 8928.0 8968.5 8857.3 8929.7 8955.6 8968.6 9000.4 34255.0 41493.4 41891.0 41988.8 41993.8 3474.1 3498.4 3609.5 3706.5 3748.2 31776.2 32256.4 32339.7 32561.0 33736.0 4177.2 4201.6 4252.9 4275.2 4334.7 321582.0 323004.0 323263.0 324077.0 324990.0 36354.6 37275.4 37723.4 37831.8 37929.8 37030.4 38942.8 38982.6 39262.4 39311.0 14607.6 14800.8 14835.7 14838.6 14863.4 13240.8 13332.8 13397.0 13397.8 13453.8 8983.7 9005.0 9020.0 9028.4 9037.3 3381.2 3395.4 3422.9 3426.4 3492.0 1031.8 1119.3 1125.5 1134.1 1183.1 31647.0 32391.5 32979.8 33149.8 34019.3 1078.7 1115.6 1130.5 1151.3 1227.3 16604.0 16619.6 16723.5 16834.9 17094.3 602108.0 605329.0 611009.0 611591.0 613359.0 59779.4 60551.1 60588.4 60819.0 60846.7 1370.7 1372.8 1382.6 1398.4 1431.9 31183.8 31532.2 31720.8 31890.0 32780.5 52322.0 52923.5 53271.7 53419.0 53494.5 471231.0 477495.0 482419.0 482697.0 484257.0 30009.0 30093.8 30279.1 30286.7 30331.8 50166.7 50490.7 50754.7 51448.2 51475.7 42980.6 43470.3 43959.3 43981.0 44943.6 42332.0 43390.3 43450.3 44176.1 44282.8 35460.0 41153.2 41218.6 41479.4 42613.4 37689.4 38206.2 38419.4 38547.2 39005.4 25032.2 25451.9 25477.9 25480.7 26042.0 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | [#2] jquery.html Cycles:180 Average:24973.99 Median:187009.97 stddev:60269.76 (32.2%) stddev-sans-first:60410.59 14:30:39 INFO - PROCESS | 15931 | Values: 399.1 401.9 410.3 410.9 421.7 18569.8 20409.8 20431.1 21029.5 21129.9 19324.0 19477.7 20162.4 20228.0 20323.9 5721.2 5922.8 5956.5 5982.7 6002.0 5433.8 5844.9 5870.1 5907.6 5917.1 5720.3 5750.6 5781.8 5811.3 5817.2 5687.3 5731.7 5846.6 5868.7 5870.3 5706.1 5707.4 5717.3 5747.6 5776.2 23394.5 23823.5 24218.8 24424.3 24489.0 2241.3 2305.4 2401.5 2421.0 2890.9 9784.6 10229.3 10257.5 10279.9 10575.7 1884.2 1897.7 1919.3 1938.4 1981.5 79877.6 80837.0 80964.2 85266.1 87404.0 10821.2 11426.8 11560.1 11733.4 11779.9 16148.2 16318.8 16342.1 16369.9 16374.2 8229.3 8461.5 8513.6 8526.1 8630.0 8082.6 8101.6 8136.1 8248.2 8321.0 4663.5 4709.2 4762.9 4781.3 4815.1 2033.3 2056.3 2083.0 2085.0 2106.6 949.8 976.2 994.7 1005.0 1055.0 18045.5 19324.8 19658.0 19789.1 19964.9 982.5 1006.2 1030.0 1039.0 1063.9 10659.7 10887.7 10986.2 11053.8 11057.3 173841.0 174211.0 371129.0 466788.0 472376.0 87776.0 89521.0 89922.6 91068.0 91619.1 960.5 964.0 970.6 982.8 1030.1 17300.6 17384.0 17528.0 17554.0 17758.6 43027.0 43073.6 43813.8 44880.1 44931.8 60643.4 61036.0 61494.0 61737.0 61998.0 8748.8 8852.5 8853.7 8898.7 8949.4 10085.5 13992.2 14054.4 14110.4 14365.8 12094.4 12138.3 12268.6 12300.2 12382.1 9457.0 12070.3 12082.9 12147.5 12245.9 12244.6 12320.6 12474.4 12511.4 12584.2 7256.6 8700.9 8955.6 8965.6 9300.3 9754.3 12057.9 12214.8 12255.8 12617.1 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | [#3] mootools.html Cycles:180 Average:5678.36 Median:4928.64 stddev:3173.81 (64.4%) stddev-sans-first:3167.03 14:30:39 INFO - PROCESS | 15931 | Values: 1479.8 1488.9 1623.9 1765.7 1776.4 7405.1 8004.9 8130.8 8584.1 8595.4 8195.4 8549.5 8577.8 8581.9 8607.4 2304.6 2330.7 2338.3 2339.5 2344.9 2348.5 2356.8 2375.7 2378.8 2381.0 2337.1 2346.9 2362.7 2369.9 2378.8 2292.7 2294.2 2297.9 2300.1 2344.8 2276.0 2276.6 2281.1 2283.1 2289.2 8483.7 8563.7 8581.7 8587.2 8622.0 5079.2 5193.7 5205.0 5206.2 5207.3 3212.4 3327.0 3400.6 3416.2 3419.1 1170.9 1185.9 1192.0 1201.0 1208.6 11694.9 11848.8 11874.3 11886.4 11890.1 4275.6 4440.0 4509.8 4612.4 4614.2 9958.7 9971.1 10029.6 10034.7 10077.3 5049.7 5074.2 5076.9 5078.3 5083.0 4221.6 4647.5 4674.7 4760.9 4807.6 3984.0 3996.3 4030.2 4104.1 4120.8 1277.8 1312.7 1326.5 1337.3 1338.4 799.3 876.0 876.6 936.3 973.0 5771.0 5882.3 5929.7 5952.6 6133.7 452.4 457.8 470.1 473.3 480.6 4106.9 4227.3 4229.3 4236.6 4262.1 10078.5 10411.2 10525.7 10531.0 10543.5 10402.6 10411.9 10455.2 10481.6 10487.5 7999.6 8057.8 8062.3 8068.0 8080.5 5865.2 6057.7 6066.7 6221.8 6257.2 9684.5 9719.5 9762.3 9876.0 9895.0 9653.3 9892.3 10043.1 10097.4 10153.7 7469.9 7545.0 7707.4 7720.1 7741.1 8123.4 8206.0 8265.2 8268.4 8281.5 7522.8 7621.5 7756.7 7796.0 7809.6 7296.8 7347.6 7359.8 7395.7 7465.0 6986.2 7031.0 7074.8 7083.4 7109.1 5222.8 5233.7 5305.2 5383.4 5407.6 5086.8 5129.1 5221.7 5321.7 5358.7 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | [#4] prototype.html Cycles:180 Average:5048.88 Median:5712.11 stddev:1487.08 (26.0%) stddev-sans-first:1448.70 14:30:39 INFO - PROCESS | 15931 | Values: 343.6 348.0 351.8 356.7 356.8 5701.7 5719.7 5723.8 5746.7 5758.4 5662.3 5667.0 5693.5 5703.7 5705.7 4006.3 4418.3 4435.9 4451.6 4455.7 4458.4 4461.8 4510.5 4510.7 4515.9 4450.3 4458.1 4466.7 4490.1 4490.7 4323.3 4433.2 4453.3 4466.6 4483.1 3999.3 4002.9 4006.0 4016.1 4024.3 5507.7 5528.9 5555.2 5555.7 5577.5 5045.2 5099.6 5101.5 5142.2 5142.4 5880.6 5881.1 5918.3 5947.9 5962.5 4384.0 4390.2 4416.8 4424.7 4435.3 5861.8 6109.8 6114.8 6117.6 6181.0 4266.6 4281.0 4292.1 4307.5 4310.6 4352.5 4354.7 4355.8 4358.3 4365.5 4771.7 5005.1 5008.8 5009.3 5024.9 5973.4 5985.3 6026.9 6046.3 6068.4 1508.9 1514.9 1521.4 1549.2 1557.8 959.9 1018.8 1044.8 1049.2 1054.5 5666.2 5670.9 5674.9 5718.5 5762.4 6043.2 6110.9 6141.3 6155.1 6166.5 5506.5 5742.5 5751.5 5766.3 5785.7 3259.8 3259.9 3265.6 3277.5 3280.9 6038.5 6245.6 6260.6 6386.1 6410.9 6385.6 6392.6 6404.3 6410.9 6414.4 6164.8 6395.7 6397.7 6419.3 6433.8 6143.6 6160.3 6165.9 6194.1 6227.7 6127.5 6128.9 6131.8 6180.0 6189.2 6150.9 6323.2 6373.5 6393.7 6398.8 4337.3 4419.3 4423.5 4425.6 4464.4 5911.6 6221.8 6234.3 6253.4 6276.6 5987.0 6034.5 6037.0 6068.6 6074.9 5965.7 5976.5 6015.3 6024.8 6049.6 5603.8 5744.7 5950.7 5968.6 5973.8 6098.7 6103.7 6107.5 6132.2 6134.8 5621.7 5921.6 5948.2 5973.4 6001.3 14:30:39 INFO - PROCESS | 15931 | 14:30:39 INFO - PROCESS | 15931 | [#5] yui.html Cycles:180 Average:20497.54 Median:4700.35 stddev:28815.59 (613.1%) stddev-sans-first:28858.39 14:30:39 INFO - PROCESS | 15931 | Values: 781.4 786.5 831.0 850.1 876.7 14285.6 14689.0 15077.9 15101.0 15106.8 14929.3 14985.5 15012.9 15013.6 15160.3 661.1 780.1 794.7 801.9 802.9 796.1 798.2 801.3 805.2 807.3 827.0 829.6 834.5 837.1 840.2 826.0 834.1 835.3 835.4 837.5 617.0 617.8 618.9 619.1 619.5 14272.1 14351.6 14382.9 14387.1 14410.4 13856.9 13970.9 14055.6 15796.4 15796.8 13187.0 13190.5 13274.1 13294.8 13459.9 4432.8 4477.5 4478.6 4492.0 4562.6 75657.2 80907.6 81894.2 81974.6 83278.0 11603.8 11623.1 11688.1 11823.8 11846.9 20337.6 20548.8 20560.9 20571.8 21036.2 8602.3 8640.7 8670.9 8695.1 8838.1 4749.5 4777.3 4783.5 4885.3 4907.6 3247.3 3351.8 3367.6 3376.5 3380.6 557.0 561.5 569.7 570.9 573.2 682.6 691.8 695.1 729.9 738.4 8808.9 9192.2 9246.5 9255.2 9639.0 593.5 610.6 695.6 712.3 748.9 4560.5 4580.9 4699.8 4700.9 4705.7 68686.0 70341.3 113715.0 117976.0 118402.0 99426.0 101414.5 102320.0 102658.0 103905.5 75757.0 76991.2 77713.0 87971.7 89245.0 9595.9 9926.9 9959.0 9960.7 10131.8 52901.5 53203.7 53319.0 54104.5 54628.0 66636.3 67700.0 68099.3 74405.6 76310.6 13315.7 14004.6 14008.6 14193.6 14345.9 15541.7 15581.4 15617.4 15965.8 16610.9 13862.5 14235.2 14592.4 14765.9 14921.9 13787.9 14113.9 14203.2 14217.4 14248.1 12324.4 12502.4 12542.8 14233.9 14985.6 11426.6 11762.7 11785.5 11837.8 11905.5 10937.5 11873.2 11982.2 12043.6 12230.4 14:30:39 INFO - PROCESS | 15931 | -------- Summary: end -------- 14:30:39 INFO - PROCESS | 15931 | 14:30:40 INFO - TEST-INFO | 15931: exit 0 14:30:40 INFO - TEST-OK | dromaeo_css | took 1111087ms 14:30:40 INFO - TEST-START | kraken 14:30:40 INFO - operating with platform_type : linux_ 14:30:40 INFO - Initialising browser for kraken test... 14:30:40 INFO - TEST-INFO | started process 16180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw4mQOM/profile http://localhost:41812/getInfo.html) 14:30:45 INFO - PROCESS | 16180 | __metrics Screen width/height:1600/1200 14:30:45 INFO - PROCESS | 16180 | colorDepth:24 14:30:45 INFO - PROCESS | 16180 | Browser inner width/height: 1024/697 14:30:45 INFO - PROCESS | 16180 | __metrics 14:30:45 ERROR - PROCESS | 16180 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:30:46 INFO - TEST-INFO | 16180: exit 0 14:30:46 INFO - Browser initialized. 14:30:46 INFO - Running cycle 1/1 for kraken test... 14:30:46 INFO - TEST-INFO | started process 16297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw4mQOM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:58 INFO - PROCESS | 16297 | RSS: Main: 168833024 14:30:58 INFO - PROCESS | 16297 | 14:31:01 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41812/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:01 INFO - PROCESS | 16297 | RSS: Main: 174112768 14:31:01 INFO - PROCESS | 16297 | 14:31:04 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41812/tests/kraken/driver.html?testName=audio-dft) 14:31:05 INFO - PROCESS | 16297 | RSS: Main: 173686784 14:31:05 INFO - PROCESS | 16297 | 14:31:08 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41812/tests/kraken/driver.html?testName=audio-fft) 14:31:08 INFO - PROCESS | 16297 | RSS: Main: 168882176 14:31:08 INFO - PROCESS | 16297 | 14:31:10 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41812/tests/kraken/driver.html?testName=audio-oscillator) 14:31:11 INFO - PROCESS | 16297 | RSS: Main: 169316352 14:31:11 INFO - PROCESS | 16297 | 14:31:13 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:14 INFO - PROCESS | 16297 | RSS: Main: 169660416 14:31:14 INFO - PROCESS | 16297 | 14:31:17 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41812/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:17 INFO - PROCESS | 16297 | RSS: Main: 169275392 14:31:17 INFO - PROCESS | 16297 | 14:31:21 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41812/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:21 INFO - PROCESS | 16297 | RSS: Main: 170131456 14:31:21 INFO - PROCESS | 16297 | 14:31:24 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41812/tests/kraken/driver.html?testName=json-parse-financial) 14:31:25 INFO - PROCESS | 16297 | RSS: Main: 169451520 14:31:25 INFO - PROCESS | 16297 | 14:31:26 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:27 INFO - PROCESS | 16297 | RSS: Main: 169250816 14:31:27 INFO - PROCESS | 16297 | 14:31:29 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:30 INFO - PROCESS | 16297 | RSS: Main: 169754624 14:31:30 INFO - PROCESS | 16297 | 14:31:32 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:32 INFO - PROCESS | 16297 | RSS: Main: 170319872 14:31:32 INFO - PROCESS | 16297 | 14:31:35 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:35 INFO - PROCESS | 16297 | RSS: Main: 170586112 14:31:35 INFO - PROCESS | 16297 | 14:31:38 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:39 INFO - PROCESS | 16297 | RSS: Main: 170438656 14:31:39 INFO - PROCESS | 16297 | 14:31:40 INFO - PROCESS | 16297 | Cycle 1(1): loaded http://localhost:41812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41812/tests/kraken/driver.html?testName=ai-astar) 14:31:41 INFO - PROCESS | 16297 | RSS: Main: 171274240 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | __start_tp_report 14:31:41 INFO - PROCESS | 16297 | _x_x_mozilla_page_load 14:31:41 INFO - PROCESS | 16297 | _x_x_mozilla_page_load_details 14:31:41 INFO - PROCESS | 16297 | |i|pagename|runs| 14:31:41 INFO - PROCESS | 16297 | |0;ai-astar;103;110;105;113;112;113;112;110;110;111 14:31:41 INFO - PROCESS | 16297 | |1;audio-beat-detection;144;117;145;164;123;145;145;120;180;118 14:31:41 INFO - PROCESS | 16297 | |2;audio-dft;164;163;162;162;162;165;173;164;164;162 14:31:41 INFO - PROCESS | 16297 | |3;audio-fft;75;76;75;159;77;76;75;79;170;77 14:31:41 INFO - PROCESS | 16297 | |4;audio-oscillator;85;85;150;85;84;84;153;84;84;146 14:31:41 INFO - PROCESS | 16297 | |5;imaging-gaussian-blur;119;117;117;117;119;117;118;117;118;118 14:31:41 INFO - PROCESS | 16297 | |6;imaging-darkroom;150;147;148;148;149;147;147;147;148;147 14:31:41 INFO - PROCESS | 16297 | |7;imaging-desaturate;96;97;100;100;100;96;95;97;95;96 14:31:41 INFO - PROCESS | 16297 | |8;json-parse-financial;58;54;56;54;54;59;53;54;54;55 14:31:41 INFO - PROCESS | 16297 | |9;json-stringify-tinderbox;61;61;60;68;61;60;61;60;59;60 14:31:41 INFO - PROCESS | 16297 | |10;stanford-crypto-aes;76;77;75;76;76;75;75;74;76;84 14:31:41 INFO - PROCESS | 16297 | |11;stanford-crypto-ccm;131;127;118;119;118;128;122;130;161;125 14:31:41 INFO - PROCESS | 16297 | |12;stanford-crypto-pbkdf2;155;159;162;158;154;159;158;156;156;156 14:31:41 INFO - PROCESS | 16297 | |13;stanford-crypto-sha256-iterative;68;64;66;65;65;63;63;64;63;64 14:31:41 INFO - PROCESS | 16297 | __end_tp_report 14:31:41 INFO - PROCESS | 16297 | __start_cc_report 14:31:41 INFO - PROCESS | 16297 | _x_x_mozilla_cycle_collect,898 14:31:41 INFO - PROCESS | 16297 | __end_cc_report 14:31:41 INFO - PROCESS | 16297 | __startTimestamp1467235901094__endTimestamp 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | ------- Summary: start ------- 14:31:41 INFO - PROCESS | 16297 | Number of tests: 14 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.35 (3.0%) stddev-sans-first:2.45 14:31:41 INFO - PROCESS | 16297 | Values: 103.0 110.0 105.0 113.0 112.0 113.0 112.0 110.0 110.0 111.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.00 stddev:21.00 (14.5%) stddev-sans-first:22.23 14:31:41 INFO - PROCESS | 16297 | Values: 144.0 117.0 145.0 164.0 123.0 145.0 145.0 120.0 180.0 118.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.31 (2.0%) stddev-sans-first:3.52 14:31:41 INFO - PROCESS | 16297 | Values: 164.0 163.0 162.0 162.0 162.0 165.0 173.0 164.0 164.0 162.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.32 (49.1%) stddev-sans-first:38.95 14:31:41 INFO - PROCESS | 16297 | Values: 75.0 76.0 75.0 159.0 77.0 76.0 75.0 79.0 170.0 77.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:84.00 stddev:31.56 (37.6%) stddev-sans-first:32.72 14:31:41 INFO - PROCESS | 16297 | Values: 85.0 85.0 150.0 85.0 84.0 84.0 153.0 84.0 84.0 146.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 14:31:41 INFO - PROCESS | 16297 | Values: 119.0 117.0 117.0 117.0 119.0 117.0 118.0 117.0 118.0 118.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:0.73 14:31:41 INFO - PROCESS | 16297 | Values: 150.0 147.0 148.0 148.0 149.0 147.0 147.0 147.0 148.0 147.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.00 stddev:2.04 (2.1%) stddev-sans-first:2.12 14:31:41 INFO - PROCESS | 16297 | Values: 96.0 97.0 100.0 100.0 100.0 96.0 95.0 97.0 95.0 96.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:1.97 (3.6%) stddev-sans-first:1.79 14:31:41 INFO - PROCESS | 16297 | Values: 58.0 54.0 56.0 54.0 54.0 59.0 53.0 54.0 54.0 55.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:2.51 (4.1%) stddev-sans-first:2.67 14:31:41 INFO - PROCESS | 16297 | Values: 61.0 61.0 60.0 68.0 61.0 60.0 61.0 60.0 59.0 60.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:2.80 (3.7%) stddev-sans-first:2.96 14:31:41 INFO - PROCESS | 16297 | Values: 76.0 77.0 75.0 76.0 76.0 75.0 75.0 74.0 76.0 84.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:127.50 stddev:12.60 (9.9%) stddev-sans-first:13.31 14:31:41 INFO - PROCESS | 16297 | Values: 131.0 127.0 118.0 119.0 118.0 128.0 122.0 130.0 161.0 125.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:158.00 stddev:2.36 (1.5%) stddev-sans-first:2.35 14:31:41 INFO - PROCESS | 16297 | Values: 155.0 159.0 162.0 158.0 154.0 159.0 158.0 156.0 156.0 156.0 14:31:41 INFO - PROCESS | 16297 | 14:31:41 INFO - PROCESS | 16297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.58 (2.5%) stddev-sans-first:1.05 14:31:41 INFO - PROCESS | 16297 | Values: 68.0 64.0 66.0 65.0 65.0 63.0 63.0 64.0 63.0 64.0 14:31:41 INFO - PROCESS | 16297 | -------- Summary: end -------- 14:31:41 INFO - PROCESS | 16297 | 14:31:42 INFO - TEST-INFO | 16297: exit 0 14:31:42 INFO - TEST-OK | kraken | took 61548ms 14:31:42 INFO - SUITE-END | took 1172s 14:31:42 INFO - Completed test suite (00:19:32) 14:31:42 INFO - javascript benchmark 14:31:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7286.370088242371, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.787039119548, 3118.267207206307, 3129.3428380040205, 3163.098516922676, 3163.841807909604, 5375.9193612095805, 5390.1375779875225, 5429.185622156673, 5448.318960129984, 5534.142207957763, 5348.652337598053, 5396.703181325026, 5439.945600543993, 5484.369297530775, 5506.614536982403, 4885.755712214393, 4923.458419573844, 4984.576311013569, 5061.6962982221, 5079.161938280179, 4910.386201724785, 5134.435212126663, 5165.431802501722, 5176.922346164811, 5194.506521880416, 4843.225083986563, 4880.902381952376, 4888.315635810989, 4915.729634870081, 4916.852494425138, 4939.827106051271, 4955.1080805455, 4959.380077490314, 4959.603231741488, 4998.125328067574, 4885.902281954341, 4918.532739389752, 4924.852254432372, 4950.67820591664, 4954.677945933503, 5257.369115706101, 5344.91982620261, 5352.759125839308, 5430.429804870471, 5444.183372494118, 5849.912251316234, 5860.706964651793, 5861.6189947653265, 5861.765529378819, 5862.179294898718, 5737.39757325479, 5891.381404952461, 5894.469497745224, 5897.233359663216, 5901.262342207224, 5403.594730395236, 5432.185172224158, 5460.672359658433, 5523.337199536041, 5531.723413829292, 5954.0, 5972.761089556456, 5977.641341519523, 5978.491828194652, 5983.611065280743, 5485.369182543979, 5746.482816546447, 5789.652620842763, 5792.9710351447975, 5795.768169273182, 5675.432456754292, 5736.42635736423, 5748.02283611787, 5821.359650438449, 5843.094320380348, 5556.249906262684, 5748.45389687979, 5782.624129431573, 5794.536437085023, 5818.33089194748, 5629.887402251932, 5799.855003624859, 5839.737211825478, 5859.707014649336, 5871.089981052858, 4410.823567057346, 4455.331700244989, 4462.219111655448, 4463.486699029589, 4468.754218517947, 3984.5019372578427, 3993.6405723485027, 4013.5986401360215, 4019.2765302245293, 4021.155557332934, 5536.861578460571, 5537.501624853782, 5636.18275350072, 5654.660720356709, 5673.517750991212, 5867.765289388462, 5869.647821130746, 5880.382559831241, 5902.763889444374, 5922.644641321534, 5536.335639723259, 5547.362053363834, 5555.194496798023, 5557.44425557441, 5573.414791446839, 4968.701877887338, 4971.353724015927, 5003.4746351633285, 5021.84934451967, 5040.899182016339, 5945.316288626776, 5948.0, 5979.880402391927, 5991.670458124758, 6009.519238460913, 5653.462921022497, 5828.067509198508, 5835.066389377764, 5848.327442344185, 5850.53195744348, 5978.551608629457, 5987.670678112746, 6025.969870150621, 6048.304444988883, 6059.878802423838, 5788.710564471844, 5789.91315130265, 5790.420957904176, 5807.535397168301, 5809.535237180931, 5667.943320566907, 5745.396733343106, 5898.1152827076285, 5900.468957793819, 5903.173555702119, 5623.128415095667, 5689.687067211343, 5690.971545142248, 5692.658440493584, 5754.194412782297, 5538.556915446835, 5601.971990140023, 5655.406182350958, 5659.518940890071, 5686.60193786431, 5556.666600004012, 5620.85947851307, 5621.52217061538, 5624.578156638187, 5631.436856314336, 5549.195366671891, 5557.305336832896, 5651.406602306699, 5684.090545512699, 5768.307803063659, 5539.196816461671, 5575.219469274224, 5588.720563971867, 5595.964746521907, 5601.747921343631], "value": 5368.522232464979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.9731362088705, 599.1312596734734, 624.9750009999598, 628.1990462160746, 673.6025744810561, 38420.23159536807, 41626.58373416265, 42173.78913105438, 42359.36460953084, 42473.0, 42368.36447453291, 42401.575984240146, 42545.0, 42600.0, 42650.360244596355, 8820.603072861704, 9025.684101056464, 9025.909740902605, 9028.458292502439, 9031.95484022579, 8877.067907869678, 8958.059403762609, 8962.283017358628, 8963.865542016874, 8966.730998070036, 8877.334199934998, 8921.152490513423, 8990.910090899106, 9005.909940900605, 9008.68469603564, 8874.20132188103, 8878.511681857495, 8883.0, 8927.955360223157, 8968.50673212973, 8857.291416686714, 8929.73210803677, 8955.641774329084, 8968.551572421418, 9000.414973026798, 34255.0, 41493.37759933603, 41891.0, 41988.79005604983, 41993.79003104995, 3474.096734848932, 3498.405271103893, 3609.530761001079, 3706.5181526401666, 3748.19413826026, 31776.205594860083, 32256.35487290241, 32339.6766032339, 32561.023169304957, 33736.0, 4177.185448837478, 4201.6008479194425, 4252.936205956913, 4275.187714334266, 4334.674899382559, 321582.0, 323004.0, 323263.0, 324077.0, 324990.0, 36354.636453635656, 37275.440868387, 37723.434148487795, 37831.81084094617, 37929.81035094807, 37030.44454333187, 38942.80528597339, 38982.6101738979, 39262.411063834064, 39311.0, 14607.561773146823, 14800.777988330183, 14835.703285934436, 14838.554843354717, 14863.405463781544, 13240.801387979189, 13332.800007999887, 13397.0, 13397.799033014513, 13453.798193027113, 8983.685571005115, 9004.954975225213, 9019.954900225588, 9028.413153145024, 9037.277017838556, 3381.188514756441, 3395.3548825723033, 3422.9486557701653, 3426.378820202547, 3491.9825400872833, 1031.7626945802508, 1119.2724728926264, 1125.5047778977387, 1134.1153899958047, 1183.1126655008743, 31647.0, 32391.51412728811, 32979.83510082434, 33149.83425082859, 34019.319613607586, 1078.741102135482, 1115.6485707002269, 1130.4743294368159, 1151.2862025544216, 1227.3372378915465, 16604.0, 16619.584510387096, 16723.49829505117, 16834.915825421038, 17094.316227351017, 602108.0, 605329.0, 611009.0, 611591.0, 613359.0, 59779.40220597825, 60551.09173362403, 60588.39411605916, 60819.0, 60846.69576652177, 1370.7327071221216, 1372.7803551431723, 1382.5644921849787, 1398.3637444962314, 1431.8854491640643, 31183.84408077945, 31532.211694707818, 31720.77954543252, 31890.0, 32780.50829237611, 52322.0, 52923.47076529185, 53271.73364133154, 53419.0, 53494.46505534895, 471231.0, 477495.0, 482419.0, 482697.0, 484257.0, 30009.0, 30093.849530752206, 30279.09162725122, 30286.69713302839, 30331.848340758155, 50166.74916625393, 50490.747546263505, 50754.74622626863, 51448.22827657513, 51475.742621286656, 42980.57019429891, 43470.347944780224, 43959.340609890234, 43981.0, 44943.55056449393, 42332.0, 43390.34914476349, 43450.348244776986, 44176.11647767091, 44282.77858610686, 35460.0, 41153.1769364617, 41218.58781412148, 41479.37780933228, 42613.36079958865, 37689.43465847959, 38206.235875282895, 38419.42370864495, 38547.229055418175, 39005.41491877567, 25032.200313300636, 25451.87274063618, 25477.872610636827, 25480.74519254858, 26042.0], "value": 19067.247115589053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.1438364707704, 401.8613578315482, 410.27791087685665, 410.90343769214235, 421.7132350001999, 18569.81430185698, 20409.795902040976, 20431.080601372956, 21029.474263143427, 21129.894350528266, 19324.0, 19477.707834382494, 20162.39512814614, 20228.0, 20323.898380508115, 5721.199032135504, 5922.763089476416, 5956.493698035672, 5982.73077711504, 6001.969990150065, 5433.75023744539, 5844.853878653025, 5870.060790273557, 5907.5864689471755, 5917.112433135021, 5720.256366672327, 5750.568707346965, 5781.797637082703, 5811.331696854852, 5817.185594016841, 5687.289088863892, 5731.656100633954, 5846.590738648296, 5868.735906884201, 5870.295564532241, 5706.087026075808, 5707.3721890592005, 5717.342505611867, 5747.59766816323, 5776.162456443834, 23394.532109357886, 23823.523529529484, 24218.757812422, 24424.26727198169, 24489.0, 2241.3276017194776, 2305.3775480620307, 2401.483681008574, 2420.987895060531, 2890.942181156386, 9784.55969481375, 10229.283950123494, 10257.487125643762, 10279.948600257025, 10575.682729518127, 1884.1615481110912, 1897.7438045863769, 1919.3378284491828, 1938.370029740326, 1981.455099847539, 79877.60061199658, 80836.99999999942, 80964.19035809625, 85266.14733852644, 87404.0, 10821.242513024014, 11426.828597571042, 11560.132990025782, 11733.4133293335, 11779.941100294614, 16148.192590370434, 16318.836811631732, 16342.101184434732, 16369.91815040941, 16374.181290935405, 8229.25936665703, 8461.492310461392, 8513.574321284035, 8526.10475900034, 8629.956850215834, 8082.636281367352, 8101.554414507259, 8136.0643525995265, 8248.216419440143, 8321.0, 4663.510331415153, 4709.222978208557, 4762.904741905212, 4781.330613714083, 4815.109204797123, 2033.3391647714552, 2056.3008577083865, 2083.0, 2084.989575052115, 2106.599746048246, 949.8432758594754, 976.1751320134475, 994.7314225159166, 1004.9648262310784, 1054.9819424255477, 18045.548861278312, 19324.80675193258, 19658.0, 19789.113650938754, 19964.90017549932, 982.5332966840693, 1006.2302338710892, 1029.994850025745, 1039.0492699180315, 1063.9361638301727, 10659.680209593569, 10887.727806804893, 10986.230963832455, 11053.834192487118, 11057.336559806437, 173841.0, 174211.0, 371129.0, 466788.0, 472376.0, 87776.0, 89521.0, 89922.55038724764, 91068.0, 91619.08380916239, 960.4573416019927, 964.0455948610964, 970.6214576315243, 982.7837875667485, 1030.1398332392537, 17300.567485812957, 17384.0, 17528.0, 17554.0, 17758.556036099202, 43027.0, 43073.569264306956, 43813.78093109514, 44880.10239795251, 44931.77534112309, 60643.39356606554, 61036.0, 61494.0, 61737.0, 61998.0, 8748.825023499367, 8852.468851868909, 8853.73438796837, 8898.688545900863, 8949.373543852129, 10085.495725213857, 13992.16047037181, 14054.437822486985, 14110.435582576582, 14365.784513232518, 12094.39528023613, 12138.271703697454, 12268.570600028956, 12300.200486968319, 12382.133250672367, 9456.952715236379, 12070.27578345302, 12082.939585302369, 12147.514099435924, 12245.87754122483, 12244.571439999558, 12320.630381088582, 12474.376281186085, 12511.4369853355, 12584.18202816814, 7256.564606123649, 8700.869486957574, 8955.552222388986, 8965.551722413722, 9300.255979521757, 9754.268429867647, 12057.939710301393, 12214.816777748163, 12255.816162757388, 12617.116801823784], "value": 9337.867800156318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.8224213094427, 1488.9478868239612, 1623.9188040597967, 1765.6733504301696, 1776.3960253513803, 7405.148407933089, 8004.879926801095, 8130.837383252347, 8584.055753867078, 8595.355348348876, 8195.42632015759, 8549.529775862326, 8577.785555361104, 8581.871271930926, 8607.354448416363, 2304.5966955782756, 2330.720313562375, 2338.3452633262714, 2339.4502291961376, 2344.8944797484155, 2348.4833336665906, 2356.7996720278798, 2375.6911601491784, 2378.7502312257225, 2380.9880950595225, 2337.123578658003, 2346.9295921122393, 2362.6574146748712, 2369.9052037918464, 2378.7740164684415, 2292.6561015847587, 2294.1740973249616, 2297.8621282723007, 2300.137448456837, 2344.788968992799, 2275.9544809103727, 2276.5674521840797, 2281.087564974007, 2283.1095872609694, 2289.1644549739226, 8483.703070392568, 8563.743087707378, 8581.742547723577, 8587.184217499327, 8621.956890215508, 5079.238114282887, 5193.662411943212, 5205.011047900886, 5206.167013277895, 5207.297014902978, 3212.421764082464, 3326.963472256185, 3400.60892997306, 3416.1630400551776, 3419.111031131899, 1170.9473073711704, 1185.9229150105216, 1191.9642410727693, 1200.9699757506132, 1208.576998050684, 11694.883051169465, 11848.822267665992, 11874.346910919896, 11886.405679716067, 11890.108241881893, 4275.593818587229, 4439.955600443955, 4509.759816050547, 4612.446506419251, 4614.192516309632, 9958.651447199314, 9971.10260076582, 10029.598816047277, 10034.69895903124, 10077.29458937882, 5049.697018178847, 5074.162763144113, 5076.873078173001, 5078.314427552307, 5082.983403319351, 4221.598948099987, 4647.512011238839, 4674.69614475058, 4760.928586071212, 4807.591354734886, 3983.960160398417, 3996.300647386696, 4030.1738143680477, 4104.056067104582, 4120.835166593362, 1277.8147168660491, 1312.7308901675324, 1326.5091915991145, 1337.2511393619604, 1338.444545513601, 799.3405440511485, 875.9605817738217, 876.6142897125244, 936.2884208001967, 972.9854052189223, 5770.971145144247, 5882.264716910387, 5929.673867937305, 5952.642841429441, 6133.693315334215, 452.39605127155613, 457.81458509303786, 470.06457150270717, 473.3396911308705, 480.6419217682849, 4106.876793696194, 4227.3447615619625, 4229.281022226229, 4236.639885609758, 4262.126264115849, 10078.546465409074, 10411.219158562986, 10525.736856578493, 10531.0, 10543.525541350658, 10402.5838966442, 10411.94794026025, 10455.16358691303, 10481.580736770444, 10487.528061237263, 7999.640016199285, 8057.798555036054, 8062.274395304451, 8067.959660201662, 8080.515169089874, 5865.178874957424, 6057.666828324484, 6066.7269972850445, 6221.844453888689, 6257.217847769029, 9684.51577421112, 9719.465429401167, 9762.267829912644, 9875.950620246853, 9895.0, 9653.324267301221, 9892.258080643836, 10043.096121349114, 10097.394156350643, 10153.746156346151, 7469.850602988018, 7545.0, 7707.421943354158, 7720.073591169095, 7741.148473668005, 8123.431359804993, 8205.95897020511, 8265.173482651686, 8268.37987150954, 8281.54451505173, 7522.811929701801, 7621.542707437571, 7756.650950707344, 7795.961020194863, 7809.570473624005, 7296.7810965671115, 7347.632618369167, 7359.77920662381, 7395.7041718330665, 7465.029546158965, 6986.196587392515, 7031.0, 7074.787756367317, 7083.362497375055, 7109.075820143348, 5222.7910883565755, 5233.659812112201, 5305.151175811851, 5383.434739352469, 5407.594430417813, 5086.847394578169, 5129.102407078672, 5221.686698798084, 5321.707306098202, 5358.678479291255], "value": 4507.091994855053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.5568117128904, 347.96694314040155, 351.8152969690912, 356.6540455757914, 356.77166613367433, 5701.74342154603, 5719.6854173020465, 5723.828285151441, 5746.7413966371505, 5758.395368486301, 5662.320521537411, 5666.971665141668, 5693.516051135658, 5703.714814259291, 5705.714714264291, 4006.3189257826093, 4418.293073108303, 4435.933460998088, 4451.577100175495, 4455.663301009684, 4458.433253397286, 4461.821527138911, 4510.488986189631, 4510.706804057726, 4515.932261016071, 4450.310201918708, 4458.063806600601, 4466.665000124987, 4490.124425736983, 4490.685652004361, 4323.286657701476, 4433.202023635744, 4453.309736990772, 4466.57567531084, 4483.14820184164, 3999.300122478555, 4002.8598999035185, 4005.9584508027833, 4016.116454380032, 4024.3158663027357, 5507.697076660782, 5528.926652505311, 5555.222388805597, 5555.666660000413, 5577.52591029763, 5045.243213517965, 5099.643024988252, 5101.51535604117, 5142.151544995071, 5142.408623008365, 5880.5883588148845, 5881.14723365114, 5918.319393269786, 5947.947957954499, 5962.522998160181, 4383.978080109611, 4390.1878152541885, 4416.763306274216, 4424.668149888771, 4435.3125265583885, 5861.765529378819, 6109.816705498843, 6114.807612515561, 6117.632942023492, 6180.969095154495, 4266.573342665709, 4280.978595107004, 4292.098659281586, 4307.5139077018375, 4310.568943105664, 4352.455943007124, 4354.738715677069, 4355.7822108894425, 4358.3244597087505, 4365.519792822787, 4771.665983381199, 5005.1491246488185, 5008.774605142778, 5009.296839074659, 5024.924626130611, 5973.432523910222, 5985.34161242263, 6026.939730602638, 6046.3349031606485, 6068.393160683896, 1508.894377393594, 1514.9394024239127, 1521.37623574334, 1549.1944189021647, 1557.766335049729, 959.8560215967522, 1018.7860549284733, 1044.7649278912183, 1049.2130901823632, 1054.5096530113533, 5666.206731057655, 5670.858228544237, 5674.858128546819, 5718.51392631631, 5762.366139724627, 6043.214382130383, 6110.877782444326, 6141.293751218578, 6155.138280640714, 6166.537509686791, 5506.504414602625, 5742.483176514133, 5751.5333589935135, 5766.261026012694, 5785.652860828363, 3259.788113772597, 3259.9348013039607, 3265.591801024872, 3277.4592192288005, 3280.852361643684, 6038.516918646497, 6245.5628106033055, 6260.561760676709, 6386.094327081167, 6410.903836442457, 6385.616862988236, 6392.584482008655, 6404.263509696445, 6410.935890641127, 6414.390632889868, 6164.845878852975, 6395.680215989182, 6397.744090236339, 6419.325970773095, 6433.806985790434, 6143.600665956698, 6160.291566469913, 6165.907511387243, 6194.132821405097, 6227.657478838707, 6127.509799215963, 6128.938710612837, 6131.84670383244, 6179.969100154471, 6189.226346706661, 6150.938490615036, 6323.20959880015, 6373.490120790419, 6393.680315984275, 6398.808035758934, 4337.284348082531, 4419.29857005049, 4423.469183697976, 4425.6238219751685, 4464.352668863062, 5911.576253735948, 6221.782237621662, 6234.3453937337745, 6253.43664083979, 6276.560640755103, 5987.042073268256, 6034.461212390987, 6037.0, 6068.575199735976, 6074.939250607437, 5965.6718880461995, 5976.491998180203, 6015.308239552507, 6024.759009639565, 6049.637021778707, 5603.823197128486, 5744.712764361849, 5950.732217050157, 5968.612040217372, 5973.761049557969, 6098.68878191191, 6103.725332359965, 6107.480864126599, 6132.233470816148, 6134.846628834136, 5621.718914054362, 5921.61509501881, 5948.234071156933, 5973.402659734165, 6001.309849367379], "value": 4573.198614568082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.4256521456729, 786.52808315011, 831.0484495252933, 850.1498501498503, 876.6975393489244, 14285.642858928519, 14689.0, 15077.92461037696, 15101.0, 15106.773398399006, 14929.328180231889, 14985.475508357209, 15012.924935375335, 15013.62465938352, 15160.317785699643, 661.110805965975, 780.0717146595533, 794.7496538590354, 801.9238172373615, 802.879568064792, 796.0924546017544, 798.2217338095369, 801.286854699318, 805.243071512779, 807.2855522862279, 827.0199813221321, 829.5810615639094, 834.4951304460775, 837.1210229259253, 840.1808236968936, 826.0252901576138, 834.1158372125536, 835.3275613131427, 835.4402550291319, 837.539353355658, 616.9727403872547, 617.7776000639766, 618.8886000519905, 619.1084837833505, 619.5013014523307, 14272.14367137975, 14351.569452916428, 14382.856171438256, 14387.136771793726, 14410.423583056665, 13856.93071534646, 13970.93014534931, 14055.578332650037, 15796.447124350707, 15796.842031579767, 13187.0, 13190.472381104744, 13274.137181083295, 13294.800577991338, 13459.865401346056, 4432.844850430251, 4477.529859364785, 4478.619317357996, 4491.955080449186, 4562.5665561771575, 75657.24342756612, 80907.5954620229, 81894.18105818985, 81974.59012704898, 83277.99999999939, 11603.825942610867, 11623.12826538013, 11688.123390745557, 11823.822642660367, 11846.881531184577, 20337.593248134956, 20548.79451205499, 20560.897195513928, 20571.794282056988, 21036.158553657988, 8602.268807151462, 8640.654373825102, 8670.86993695095, 8695.130486951255, 8838.0621212348, 4749.501302363271, 4777.283407488904, 4783.545563171493, 4885.267209918541, 4907.631927605444, 3247.269364392993, 3351.765376423627, 3367.562216911786, 3376.5272861799367, 3380.560527131506, 556.9832905012856, 561.4834352395806, 569.7066011004337, 570.9371969083397, 573.1517354315636, 682.5938566552893, 691.8305015271291, 695.1102588686489, 729.8686236477484, 738.3502517784316, 8808.911910880937, 9192.17270445663, 9246.537673116318, 9255.167034966886, 9638.95180524107, 593.5014587746227, 610.6427739772283, 695.5617960684737, 712.3197346534048, 748.8614606297853, 4560.5211452796975, 4580.885477863014, 4699.812007519729, 4700.88247793801, 4705.717656940595, 68686.0, 70341.29658703449, 113715.0, 117976.0, 118402.0, 99426.0, 101414.49292753637, 102320.0, 102658.0, 103905.48047259715, 75757.0, 76991.23008769953, 77713.0, 87971.68042479368, 89244.9999999987, 9595.856062159213, 9926.900730992886, 9958.950205249217, 9960.651377201762, 10131.848022279524, 52901.47098529119, 53203.733981329846, 53319.0, 54104.458955409944, 54628.0, 66636.33363666301, 67700.0, 68099.31900681127, 74405.62797186196, 76310.6184469074, 13315.66710832237, 14004.579862604138, 14008.649783755487, 14193.645158871112, 14345.928270358581, 15541.689166216838, 15581.376744930076, 15617.375304987674, 15965.760513592537, 16610.916945415196, 13862.514811981533, 14235.234226050881, 14592.416303347747, 14765.926170369079, 14921.850781492047, 13787.862121378657, 14113.858861411254, 14203.218822964836, 14217.431302748188, 14248.145111293356, 12324.445399956845, 12502.374881255719, 12542.811857822322, 14233.857661423668, 14985.550433487013, 11426.600068997544, 11762.70593235176, 11785.528578856749, 11837.82243266369, 11905.464254108412, 10937.507812148313, 11873.168878178445, 11982.161248712506, 12043.638690839289, 12230.449629766505], "value": 7594.852486564102, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 105.0, 113.0, 112.0, 113.0, 112.0, 110.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 145.0, 164.0, 123.0, 145.0, 145.0, 120.0, 180.0, 118.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 162.0, 165.0, 173.0, 164.0, 164.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 159.0, 77.0, 76.0, 75.0, 79.0, 170.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 150.0, 85.0, 84.0, 84.0, 153.0, 84.0, 84.0, 146.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 100.0, 100.0, 100.0, 96.0, 95.0, 97.0, 95.0, 96.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 56.0, 54.0, 54.0, 59.0, 53.0, 54.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 68.0, 61.0, 60.0, 61.0, 60.0, 59.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 76.0, 76.0, 75.0, 75.0, 74.0, 76.0, 84.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 118.0, 119.0, 118.0, 128.0, 122.0, 130.0, 161.0, 125.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 162.0, 158.0, 154.0, 159.0, 158.0, 156.0, 156.0, 156.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 65.0, 65.0, 63.0, 63.0, 64.0, 63.0, 64.0], "value": 64.5, "unit": "score"}]}]} 14:31:42 INFO - Return code: 0 14:31:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:42 ERROR - # TBPL SUCCESS # 14:31:42 INFO - Running post-action listener: _resource_record_post_action 14:31:42 INFO - ##### 14:31:42 INFO - ##### Finished run-tests step (success) 14:31:42 INFO - ##### 14:31:42 INFO - Running post-run listener: _resource_record_post_run 14:31:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565080064; Read time: 8; Write time: 648616 14:31:42 INFO - TinderboxPrint: CPU usage
13.2% 14:31:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:31:42 INFO - TinderboxPrint: I/O write bytes / time
565,080,064 / 648,616 14:31:42 INFO - TinderboxPrint: CPU idle
8,242.6 (86.7%) 14:31:42 INFO - TinderboxPrint: CPU user
1,202.4 (12.7%) 14:31:42 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:42 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 270106624; Read time: 0; Write time: 293728 14:31:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 294612992; Read time: 0; Write time: 354824 14:31:43 INFO - Running post-run listener: _upload_blobber_files 14:31:43 INFO - Blob upload gear active. 14:31:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:43 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 14:31:43 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'] 14:31:43 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 14:31:43 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:44 INFO - (blobuploader) - INFO - Done attempting. 14:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:48 INFO - (blobuploader) - INFO - Done attempting. 14:31:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:48 INFO - (blobuploader) - INFO - Done attempting. 14:31:48 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:48 INFO - Return code: 0 14:31:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8340efa4eb3b1a0a4f4ab92e7111673be5151a93d751bde6dcf9109a2ae6a40ba67100b329fee86d8ad480ec63a6f7c6a071d5f394d7330defdc0922970c5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6fc99cb465a84e163a442cdfdeaa984a78f9c720303bbc06046586374752ca19df842f02151d50415f8bfc13b2fea24ad6c77e690fbc2a0d1a98a7b7019a8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8bb3702c3fd53d47820570a279c8f5cb08cfe76840e5a5dd2b8ecc19a67f9c34c227479755e4d1c408b907d29596c4adead36af352574f23fe968a1e63d3b54"} 14:31:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:48 INFO - Contents: 14:31:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8340efa4eb3b1a0a4f4ab92e7111673be5151a93d751bde6dcf9109a2ae6a40ba67100b329fee86d8ad480ec63a6f7c6a071d5f394d7330defdc0922970c5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6fc99cb465a84e163a442cdfdeaa984a78f9c720303bbc06046586374752ca19df842f02151d50415f8bfc13b2fea24ad6c77e690fbc2a0d1a98a7b7019a8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8bb3702c3fd53d47820570a279c8f5cb08cfe76840e5a5dd2b8ecc19a67f9c34c227479755e4d1c408b907d29596c4adead36af352574f23fe968a1e63d3b54"} 14:31:48 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:48 INFO - Copying logs to upload dir... 14:31:48 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.942317 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-29 14:31:48.921536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:31:48.924710) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488 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/8340efa4eb3b1a0a4f4ab92e7111673be5151a93d751bde6dcf9109a2ae6a40ba67100b329fee86d8ad480ec63a6f7c6a071d5f394d7330defdc0922970c5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6fc99cb465a84e163a442cdfdeaa984a78f9c720303bbc06046586374752ca19df842f02151d50415f8bfc13b2fea24ad6c77e690fbc2a0d1a98a7b7019a8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8bb3702c3fd53d47820570a279c8f5cb08cfe76840e5a5dd2b8ecc19a67f9c34c227479755e4d1c408b907d29596c4adead36af352574f23fe968a1e63d3b54"} build_url:https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/UzqWMHiMTAmvJBPskLaXvg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8340efa4eb3b1a0a4f4ab92e7111673be5151a93d751bde6dcf9109a2ae6a40ba67100b329fee86d8ad480ec63a6f7c6a071d5f394d7330defdc0922970c5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6fc99cb465a84e163a442cdfdeaa984a78f9c720303bbc06046586374752ca19df842f02151d50415f8bfc13b2fea24ad6c77e690fbc2a0d1a98a7b7019a8c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8bb3702c3fd53d47820570a279c8f5cb08cfe76840e5a5dd2b8ecc19a67f9c34c227479755e4d1c408b907d29596c4adead36af352574f23fe968a1e63d3b54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:31:48.950158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:31:48.950521) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467234381.620345-390961488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:31:49.036283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:31:49.036628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:31:49.036928) ========= ========= Total master_lag: 0.18 =========