builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1469123104.46 results: success (0) buildid: 20160721073519 builduid: fad4f7f03dac4777826449cc4c9a9b9d revision: 661d3548825aff461b50901da7ec5e32a8366bf4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.459988) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.460570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.460849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.478653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.479234) ========= 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=fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 10:45:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-21 10:45:05 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.666363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.666666) ========= 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=fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015598 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.715592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:04.715897) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 661d3548825aff461b50901da7ec5e32a8366bf4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 661d3548825aff461b50901da7ec5e32a8366bf4 --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=fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 10:45:05,522 truncating revision to first 12 chars 2016-07-21 10:45:05,522 Setting DEBUG logging. 2016-07-21 10:45:05,522 attempt 1/10 2016-07-21 10:45:05,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/661d3548825a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 10:45:05,840 unpacking tar archive at: mozilla-aurora-661d3548825a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618423 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:05.347709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:05.348036) ========= script_repo_revision: 661d3548825aff461b50901da7ec5e32a8366bf4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:05.348454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:05.348716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 10:45:05.359635) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-21 10:45:05.360002) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:45:06 INFO - MultiFileLogger online at 20160721 10:45:06 in /builds/slave/test 10:45:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:45:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:45:06 INFO - {'append_to_log': False, 10:45:06 INFO - 'base_work_dir': '/builds/slave/test', 10:45:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:45:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:45:06 INFO - 'branch': 'Mozilla-Aurora', 10:45:06 INFO - 'buildbot_json_path': 'buildprops.json', 10:45:06 INFO - 'config_files': ('talos/linux_config.py',), 10:45:06 INFO - 'default_actions': ('clobber', 10:45:06 INFO - 'read-buildbot-config', 10:45:06 INFO - 'download-and-extract', 10:45:06 INFO - 'populate-webroot', 10:45:06 INFO - 'create-virtualenv', 10:45:06 INFO - 'install', 10:45:06 INFO - 'run-tests'), 10:45:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:45:06 INFO - 'download_minidump_stackwalk': True, 10:45:06 INFO - 'download_symbols': 'ondemand', 10:45:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:45:06 INFO - 'tooltool.py': '/tools/tooltool.py', 10:45:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:45:06 INFO - '/tools/misc-python/virtualenv.py')}, 10:45:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:45:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:45:06 INFO - 'installer_path': 'installer.exe', 10:45:06 INFO - 'log_level': 'info', 10:45:06 INFO - 'log_name': 'talos', 10:45:06 INFO - 'log_to_console': True, 10:45:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:45:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:45:06 INFO - 'opt_config_files': (), 10:45:06 INFO - 'pip_index': False, 10:45:06 INFO - 'sps_profile': False, 10:45:06 INFO - 'sps_profile_interval': 0, 10:45:06 INFO - 'suite': 'dromaeojs-e10s', 10:45:06 INFO - 'system_bits': '32', 10:45:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:45:06 INFO - 'title': 'talos-linux64-ix-048', 10:45:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:45:06 INFO - 'use_talos_json': True, 10:45:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:45:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:45:06 INFO - 'work_dir': 'build'} 10:45:06 INFO - ##### 10:45:06 INFO - ##### Running clobber step. 10:45:06 INFO - ##### 10:45:06 INFO - Running pre-action listener: _resource_record_pre_action 10:45:06 INFO - Running main action method: clobber 10:45:06 INFO - rmtree: /builds/slave/test/build 10:45:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:45:07 INFO - Running post-action listener: _resource_record_post_action 10:45:07 INFO - ##### 10:45:07 INFO - ##### Finished clobber step (success) 10:45:07 INFO - ##### 10:45:07 INFO - ##### 10:45:07 INFO - ##### Running read-buildbot-config step. 10:45:07 INFO - ##### 10:45:07 INFO - Running pre-action listener: _resource_record_pre_action 10:45:07 INFO - Running main action method: read_buildbot_config 10:45:07 INFO - Using buildbot properties: 10:45:07 INFO - { 10:45:07 INFO - "project": "", 10:45:07 INFO - "product": "firefox", 10:45:07 INFO - "script_repo_revision": "production", 10:45:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:45:07 INFO - "repository": "", 10:45:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:45:07 INFO - "buildid": "20160721073519", 10:45:07 INFO - "pgo_build": "True", 10:45:07 INFO - "basedir": "/builds/slave/test", 10:45:07 INFO - "buildnumber": 436, 10:45:07 INFO - "slavename": "talos-linux64-ix-048", 10:45:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:45:07 INFO - "platform": "ubuntu64_hw", 10:45:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:45:07 INFO - "branch": "mozilla-aurora", 10:45:07 INFO - "repo_path": "releases/mozilla-aurora", 10:45:07 INFO - "revision": "661d3548825aff461b50901da7ec5e32a8366bf4", 10:45:07 INFO - "stage_platform": "linux64-pgo", 10:45:07 INFO - "builduid": "fad4f7f03dac4777826449cc4c9a9b9d", 10:45:07 INFO - "slavebuilddir": "test" 10:45:07 INFO - } 10:45:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:45:07 INFO - Running post-action listener: _resource_record_post_action 10:45:07 INFO - ##### 10:45:07 INFO - ##### Finished read-buildbot-config step (success) 10:45:07 INFO - ##### 10:45:07 INFO - ##### 10:45:07 INFO - ##### Running download-and-extract step. 10:45:07 INFO - ##### 10:45:07 INFO - Running pre-action listener: _resource_record_pre_action 10:45:07 INFO - Running main action method: download_and_extract 10:45:07 INFO - mkdir: /builds/slave/test/build/tests 10:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:45:07 INFO - https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:45:12 INFO - Downloaded 1361 bytes. 10:45:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:45:12 INFO - Using the following test package requirements: 10:45:12 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:45:12 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:45:12 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:45:12 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'jsshell-linux-x86_64.zip'], 10:45:12 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:45:12 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:45:12 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:45:12 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:45:12 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:45:12 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:45:12 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:45:12 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:45:12 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')]} 10:45:12 INFO - https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:45:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:45:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:45:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:45:17 INFO - Downloaded 24489791 bytes. 10:45:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:45:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:45:18 INFO - Return code: 0 10:45:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:45:18 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')]} 10:45:18 INFO - https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:45:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:45:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:45:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:45:21 INFO - Downloaded 24489791 bytes. 10:45:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:45:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:45:22 INFO - Return code: 0 10:45: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')]} 10:45:22 INFO - https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:45:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:45:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:45:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:45:23 INFO - Downloaded 10833369 bytes. 10:45:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:45:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:45:24 INFO - Return code: 0 10:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:24 INFO - https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:45:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:45:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:45:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:45:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:45:27 INFO - Downloaded 63650602 bytes. 10:45:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:45:27 INFO - mkdir: /builds/slave/test/properties 10:45:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:45:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:45:27 INFO - Contents: 10:45:27 INFO - build_url:https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:45:28 INFO - Running post-action listener: _resource_record_post_action 10:45:28 INFO - Running post-action listener: set_extra_try_arguments 10:45:28 INFO - ##### 10:45:28 INFO - ##### Finished download-and-extract step (success) 10:45:28 INFO - ##### 10:45:28 INFO - ##### 10:45:28 INFO - ##### Running populate-webroot step. 10:45:28 INFO - ##### 10:45:28 INFO - Running pre-action listener: _resource_record_pre_action 10:45:28 INFO - Running main action method: populate_webroot 10:45:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:45:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:45:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:45:28 INFO - '--tppagecycles', 10:45:28 INFO - '7'], 10:45:28 INFO - 'tests': ['tsvgm']}}, 10:45:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:45:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:45:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:45:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:45:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['damp', 'tps']}, 10:45:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'tests': ['damp', 'tps']}, 10:45:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['dromaeo_dom']}, 10:45:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:45:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['a11yr', 10:45:28 INFO - 'ts_paint', 10:45:28 INFO - 'tpaint', 10:45:28 INFO - 'sessionrestore', 10:45:28 INFO - 'sessionrestore_no_auto_restore', 10:45:28 INFO - 'tabpaint']}, 10:45:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:45:28 INFO - 'ts_paint', 10:45:28 INFO - 'tpaint', 10:45:28 INFO - 'sessionrestore', 10:45:28 INFO - 'sessionrestore_no_auto_restore', 10:45:28 INFO - 'tabpaint']}, 10:45:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:45:28 INFO - 'ts_paint', 10:45:28 INFO - 'tpaint', 10:45:28 INFO - 'sessionrestore', 10:45:28 INFO - 'sessionrestore_no_auto_restore', 10:45:28 INFO - 'tabpaint']}, 10:45:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:45:28 INFO - 'ts_paint', 10:45:28 INFO - 'tpaint', 10:45:28 INFO - 'sessionrestore', 10:45:28 INFO - 'sessionrestore_no_auto_restore', 10:45:28 INFO - 'tabpaint']}, 10:45:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['a11yr', 10:45:28 INFO - 'ts_paint', 10:45:28 INFO - 'tpaint', 10:45:28 INFO - 'sessionrestore', 10:45:28 INFO - 'sessionrestore_no_auto_restore', 10:45:28 INFO - 'tabpaint']}, 10:45:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['a11yr', 10:45:28 INFO - 'ts_paint', 10:45:28 INFO - 'tpaint', 10:45:28 INFO - 'sessionrestore', 10:45:28 INFO - 'sessionrestore_no_auto_restore', 10:45:28 INFO - 'tabpaint']}, 10:45:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['tsvgx', 10:45:28 INFO - 'tsvgr_opacity', 10:45:28 INFO - 'tart', 10:45:28 INFO - 'tscrollx', 10:45:28 INFO - 'cart']}, 10:45:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:45:28 INFO - 'tsvgr_opacity', 10:45:28 INFO - 'tart', 10:45:28 INFO - 'tscrollx', 10:45:28 INFO - 'cart']}, 10:45:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'talos_options': ['--disable-e10s'], 10:45:28 INFO - 'tests': ['tp5o']}, 10:45:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'tests': ['tp5o']}, 10:45:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'talos_options': ['--disable-e10s', 10:45:28 INFO - '--xperf_path', 10:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:28 INFO - 'tests': ['tp5n']}, 10:45:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:28 INFO - 'talos_options': ['--xperf_path', 10:45:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:28 INFO - 'tests': ['tp5n']}}, 10:45:28 INFO - 'talos.zip': {'path': '', 10:45:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:45:28 INFO - Running post-action listener: _resource_record_post_action 10:45:28 INFO - ##### 10:45:28 INFO - ##### Finished populate-webroot step (success) 10:45:28 INFO - ##### 10:45:28 INFO - ##### 10:45:28 INFO - ##### Running create-virtualenv step. 10:45:28 INFO - ##### 10:45:28 INFO - Running pre-action listener: _resource_record_pre_action 10:45:28 INFO - Running main action method: create_virtualenv 10:45:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:45:28 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 10:45:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:45:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:45:28 INFO - Using real prefix '/usr' 10:45:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:45:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:45:30 INFO - Installing pip.................done. 10:45:30 INFO - Return code: 0 10:45:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:45:30 INFO - Using env: {'DISPLAY': ':0', 10:45:30 INFO - 'HOME': '/home/cltbld', 10:45:30 INFO - 'LANG': 'en_US.UTF-8', 10:45:30 INFO - 'LANGUAGE': 'en_US:en', 10:45:30 INFO - 'LOGNAME': 'cltbld', 10:45:30 INFO - 'MAIL': '/var/mail/cltbld', 10:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:30 INFO - 'MOZ_NO_REMOTE': '1', 10:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:30 INFO - 'NO_EM_RESTART': '1', 10:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:30 INFO - 'PWD': '/builds/slave/test', 10:45:30 INFO - 'SHELL': '/bin/bash', 10:45:30 INFO - 'SHLVL': '1', 10:45:30 INFO - 'TERM': 'linux', 10:45:30 INFO - 'TMOUT': '86400', 10:45:30 INFO - 'USER': 'cltbld', 10:45:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:30 INFO - '_': '/tools/buildbot/bin/python'} 10:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:30 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 10:45:30 INFO - Cleaning up... 10:45:30 INFO - Return code: 0 10:45:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:45:30 INFO - Using env: {'DISPLAY': ':0', 10:45:30 INFO - 'HOME': '/home/cltbld', 10:45:30 INFO - 'LANG': 'en_US.UTF-8', 10:45:30 INFO - 'LANGUAGE': 'en_US:en', 10:45:30 INFO - 'LOGNAME': 'cltbld', 10:45:30 INFO - 'MAIL': '/var/mail/cltbld', 10:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:30 INFO - 'MOZ_NO_REMOTE': '1', 10:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:30 INFO - 'NO_EM_RESTART': '1', 10:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:30 INFO - 'PWD': '/builds/slave/test', 10:45:30 INFO - 'SHELL': '/bin/bash', 10:45:30 INFO - 'SHLVL': '1', 10:45:30 INFO - 'TERM': 'linux', 10:45:30 INFO - 'TMOUT': '86400', 10:45:30 INFO - 'USER': 'cltbld', 10:45:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:30 INFO - '_': '/tools/buildbot/bin/python'} 10:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:31 INFO - Downloading/unpacking psutil>=3.1.1 10:45:31 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 10:45:31 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 10:45:31 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 10:45:31 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 10:45:31 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 10:45:31 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 10:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:45:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:33 INFO - Installing collected packages: psutil 10:45:33 INFO - Running setup.py install for psutil 10:45:33 INFO - building 'psutil._psutil_linux' extension 10:45:33 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 10:45:33 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 10:45:33 INFO - building 'psutil._psutil_posix' extension 10:45:33 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 10:45:33 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 10:45:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:33 INFO - Successfully installed psutil 10:45:33 INFO - Cleaning up... 10:45:33 INFO - Return code: 0 10:45:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:45:33 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')]} 10:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 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')]} 10:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:33 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 10:45:33 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 10:45:33 INFO - Using env: {'DISPLAY': ':0', 10:45:33 INFO - 'HOME': '/home/cltbld', 10:45:33 INFO - 'LANG': 'en_US.UTF-8', 10:45:33 INFO - 'LANGUAGE': 'en_US:en', 10:45:33 INFO - 'LOGNAME': 'cltbld', 10:45:33 INFO - 'MAIL': '/var/mail/cltbld', 10:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:33 INFO - 'MOZ_NO_REMOTE': '1', 10:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:33 INFO - 'NO_EM_RESTART': '1', 10:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:33 INFO - 'PWD': '/builds/slave/test', 10:45:33 INFO - 'SHELL': '/bin/bash', 10:45:33 INFO - 'SHLVL': '1', 10:45:33 INFO - 'TERM': 'linux', 10:45:33 INFO - 'TMOUT': '86400', 10:45:33 INFO - 'USER': 'cltbld', 10:45:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:33 INFO - '_': '/tools/buildbot/bin/python'} 10:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:45:33 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 10:45:33 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 10:45:33 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 10:45:33 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 10:45:33 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 10:45:33 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 10:45:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:45:35 INFO - Installing collected packages: mozsystemmonitor 10:45:35 INFO - Running setup.py install for mozsystemmonitor 10:45:35 INFO - Successfully installed mozsystemmonitor 10:45:35 INFO - Cleaning up... 10:45:36 INFO - Return code: 0 10:45:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:45:36 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')]} 10:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:36 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')]} 10:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:36 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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:36 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 10:45:36 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 10:45:36 INFO - Using env: {'DISPLAY': ':0', 10:45:36 INFO - 'HOME': '/home/cltbld', 10:45:36 INFO - 'LANG': 'en_US.UTF-8', 10:45:36 INFO - 'LANGUAGE': 'en_US:en', 10:45:36 INFO - 'LOGNAME': 'cltbld', 10:45:36 INFO - 'MAIL': '/var/mail/cltbld', 10:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:36 INFO - 'MOZ_NO_REMOTE': '1', 10:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:36 INFO - 'NO_EM_RESTART': '1', 10:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:36 INFO - 'PWD': '/builds/slave/test', 10:45:36 INFO - 'SHELL': '/bin/bash', 10:45:36 INFO - 'SHLVL': '1', 10:45:36 INFO - 'TERM': 'linux', 10:45:36 INFO - 'TMOUT': '86400', 10:45:36 INFO - 'USER': 'cltbld', 10:45:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:36 INFO - '_': '/tools/buildbot/bin/python'} 10:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:45:36 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 10:45:36 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 10:45:36 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 10:45:36 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 10:45:36 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 10:45:36 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 10:45:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:45:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:45:38 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 10:45:38 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 10:45:38 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 10:45:38 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 10:45:38 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 10:45:38 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 10:45:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:45:38 INFO - warning: no files found matching '*.txt' 10:45:38 INFO - no previously-included directories found matching 'build' 10:45:38 INFO - no previously-included directories found matching 'dist' 10:45:38 INFO - no previously-included directories found matching '.git*' 10:45:38 INFO - Installing collected packages: jsonschema, functools32 10:45:38 INFO - Running setup.py install for functools32 10:45:38 INFO - warning: no files found matching '*.txt' 10:45:38 INFO - no previously-included directories found matching 'build' 10:45:38 INFO - no previously-included directories found matching 'dist' 10:45:38 INFO - no previously-included directories found matching '.git*' 10:45:38 INFO - Successfully installed jsonschema functools32 10:45:38 INFO - Cleaning up... 10:45:38 INFO - Return code: 0 10:45:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:45:38 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')]} 10:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 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')]} 10:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:38 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 10:45:38 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 10:45:38 INFO - Using env: {'DISPLAY': ':0', 10:45:38 INFO - 'HOME': '/home/cltbld', 10:45:38 INFO - 'LANG': 'en_US.UTF-8', 10:45:38 INFO - 'LANGUAGE': 'en_US:en', 10:45:38 INFO - 'LOGNAME': 'cltbld', 10:45:38 INFO - 'MAIL': '/var/mail/cltbld', 10:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:38 INFO - 'MOZ_NO_REMOTE': '1', 10:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:38 INFO - 'NO_EM_RESTART': '1', 10:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:38 INFO - 'PWD': '/builds/slave/test', 10:45:38 INFO - 'SHELL': '/bin/bash', 10:45:38 INFO - 'SHLVL': '1', 10:45:38 INFO - 'TERM': 'linux', 10:45:38 INFO - 'TMOUT': '86400', 10:45:38 INFO - 'USER': 'cltbld', 10:45:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:38 INFO - '_': '/tools/buildbot/bin/python'} 10:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:45:38 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 10:45:38 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 10:45:38 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 10:45:38 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 10:45:38 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 10:45:38 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 10:45:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:45:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:45:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:45:41 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 10:45:41 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 10:45:41 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 10:45:41 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 10:45:41 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 10:45:41 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 10:45:41 INFO - Downloading docopt-0.6.1.tar.gz 10:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:45:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:45:41 INFO - Running setup.py install for blobuploader 10:45:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:45:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:45:41 INFO - Running setup.py install for requests 10:45:41 INFO - Running setup.py install for docopt 10:45:42 INFO - Successfully installed blobuploader requests docopt 10:45:42 INFO - Cleaning up... 10:45:42 INFO - Return code: 0 10:45:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:42 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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:42 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 10:45:42 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 10:45:42 INFO - Using env: {'DISPLAY': ':0', 10:45:42 INFO - 'HOME': '/home/cltbld', 10:45:42 INFO - 'LANG': 'en_US.UTF-8', 10:45:42 INFO - 'LANGUAGE': 'en_US:en', 10:45:42 INFO - 'LOGNAME': 'cltbld', 10:45:42 INFO - 'MAIL': '/var/mail/cltbld', 10:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:42 INFO - 'MOZ_NO_REMOTE': '1', 10:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:42 INFO - 'NO_EM_RESTART': '1', 10:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:42 INFO - 'PWD': '/builds/slave/test', 10:45:42 INFO - 'SHELL': '/bin/bash', 10:45:42 INFO - 'SHLVL': '1', 10:45:42 INFO - 'TERM': 'linux', 10:45:42 INFO - 'TMOUT': '86400', 10:45:42 INFO - 'USER': 'cltbld', 10:45:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:42 INFO - '_': '/tools/buildbot/bin/python'} 10:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:42 INFO - Running setup.py (path:/tmp/pip-AxaguG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:42 INFO - Running setup.py (path:/tmp/pip-SBgBCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:42 INFO - Running setup.py (path:/tmp/pip-2lf0We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:42 INFO - Running setup.py (path:/tmp/pip-H7M4GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:42 INFO - Running setup.py (path:/tmp/pip-CJyLMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:42 INFO - Running setup.py (path:/tmp/pip-EqT8R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:42 INFO - Running setup.py (path:/tmp/pip-A_kcMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:42 INFO - Running setup.py (path:/tmp/pip-ZhPmkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:42 INFO - Running setup.py (path:/tmp/pip-qf3G75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:42 INFO - Running setup.py (path:/tmp/pip-j0DHJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:43 INFO - Running setup.py (path:/tmp/pip-fPJ141-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:43 INFO - Running setup.py (path:/tmp/pip-EhnpBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:43 INFO - Running setup.py (path:/tmp/pip-omw744-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:43 INFO - Running setup.py (path:/tmp/pip-dlheXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:43 INFO - Running setup.py (path:/tmp/pip-duX6fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:43 INFO - Running setup.py (path:/tmp/pip-8yUvvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:43 INFO - Running setup.py (path:/tmp/pip-rmO_fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:45:43 INFO - Running setup.py install for manifestparser 10:45:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:45:43 INFO - Running setup.py install for mozcrash 10:45:43 INFO - Running setup.py install for mozdebug 10:45:43 INFO - Running setup.py install for mozdevice 10:45:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:45:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:45:43 INFO - Running setup.py install for mozfile 10:45:44 INFO - Running setup.py install for mozhttpd 10:45:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Running setup.py install for mozinfo 10:45:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Running setup.py install for mozInstall 10:45:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Running setup.py install for mozleak 10:45:44 INFO - Running setup.py install for mozlog 10:45:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Running setup.py install for moznetwork 10:45:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Running setup.py install for mozprocess 10:45:44 INFO - Running setup.py install for mozprofile 10:45:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Running setup.py install for mozrunner 10:45:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:45:44 INFO - Running setup.py install for mozscreenshot 10:45:45 INFO - Running setup.py install for moztest 10:45:45 INFO - Running setup.py install for mozversion 10:45:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:45:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:45:45 INFO - Cleaning up... 10:45:45 INFO - Return code: 0 10:45:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:45 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')]} 10:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:45 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')]} 10:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:45 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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:45 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 10:45:45 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 10:45:45 INFO - Using env: {'DISPLAY': ':0', 10:45:45 INFO - 'HOME': '/home/cltbld', 10:45:45 INFO - 'LANG': 'en_US.UTF-8', 10:45:45 INFO - 'LANGUAGE': 'en_US:en', 10:45:45 INFO - 'LOGNAME': 'cltbld', 10:45:45 INFO - 'MAIL': '/var/mail/cltbld', 10:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:45 INFO - 'MOZ_NO_REMOTE': '1', 10:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:45 INFO - 'NO_EM_RESTART': '1', 10:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:45 INFO - 'PWD': '/builds/slave/test', 10:45:45 INFO - 'SHELL': '/bin/bash', 10:45:45 INFO - 'SHLVL': '1', 10:45:45 INFO - 'TERM': 'linux', 10:45:45 INFO - 'TMOUT': '86400', 10:45:45 INFO - 'USER': 'cltbld', 10:45:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:45 INFO - '_': '/tools/buildbot/bin/python'} 10:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:45 INFO - Running setup.py (path:/tmp/pip-C_I7F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:45 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)) 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:45 INFO - Running setup.py (path:/tmp/pip-DZXtwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:45 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)) 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:45 INFO - Running setup.py (path:/tmp/pip-IoIR39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:45 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)) 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:45 INFO - Running setup.py (path:/tmp/pip-eHNS3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:45 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)) 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:45 INFO - Running setup.py (path:/tmp/pip-Ju6xyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:45 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)) 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:45 INFO - Running setup.py (path:/tmp/pip-0hN9zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:46 INFO - Running setup.py (path:/tmp/pip-w9qzXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:46 INFO - Running setup.py (path:/tmp/pip-d6ykG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:46 INFO - Running setup.py (path:/tmp/pip-SaMOKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:46 INFO - Running setup.py (path:/tmp/pip-40uuAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:46 INFO - Running setup.py (path:/tmp/pip-ow18gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:46 INFO - Running setup.py (path:/tmp/pip-dgvl6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:46 INFO - Running setup.py (path:/tmp/pip-_V7rzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:46 INFO - Running setup.py (path:/tmp/pip-wFI8h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:46 INFO - Running setup.py (path:/tmp/pip-LEzidr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:46 INFO - Running setup.py (path:/tmp/pip-IoJ31d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:46 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)) 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:46 INFO - Running setup.py (path:/tmp/pip-IeX5Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:46 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)) 10:45:46 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)) 10:45:46 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)) 10:45:46 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)) 10:45:46 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)) 10:45:46 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)) 10:45:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45:46 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 10:45:46 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 10:45:46 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 10:45:46 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 10:45:46 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 10:45:46 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 10:45:48 INFO - Downloading blessings-1.6.tar.gz 10:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:45:48 INFO - Installing collected packages: blessings 10:45:48 INFO - Running setup.py install for blessings 10:45:48 INFO - Successfully installed blessings 10:45:48 INFO - Cleaning up... 10:45:48 INFO - Return code: 0 10:45:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:49 INFO - Reading from file tmpfile_stdout 10:45:49 INFO - Current package versions: 10:45:49 INFO - argparse == 1.2.1 10:45:49 INFO - blessings == 1.6 10:45:49 INFO - blobuploader == 1.2.4 10:45:49 INFO - docopt == 0.6.1 10:45:49 INFO - functools32 == 3.2.3-2 10:45:49 INFO - jsonschema == 2.5.1 10:45:49 INFO - manifestparser == 1.1 10:45:49 INFO - mozInstall == 1.12 10:45:49 INFO - mozcrash == 0.17 10:45:49 INFO - mozdebug == 0.1 10:45:49 INFO - mozdevice == 0.48 10:45:49 INFO - mozfile == 1.2 10:45:49 INFO - mozhttpd == 0.7 10:45:49 INFO - mozinfo == 0.9 10:45:49 INFO - mozleak == 0.1 10:45:49 INFO - mozlog == 3.2 10:45:49 INFO - moznetwork == 0.27 10:45:49 INFO - mozprocess == 0.23 10:45:49 INFO - mozprofile == 0.28 10:45:49 INFO - mozrunner == 6.12 10:45:49 INFO - mozscreenshot == 0.1 10:45:49 INFO - mozsystemmonitor == 0.3 10:45:49 INFO - moztest == 0.7 10:45:49 INFO - mozversion == 1.4 10:45:49 INFO - psutil == 3.1.1 10:45:49 INFO - requests == 1.2.3 10:45:49 INFO - wsgiref == 0.1.2 10:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:49 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')]} 10:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:49 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')]} 10:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:49 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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:49 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 10:45:49 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 10:45:49 INFO - Using env: {'DISPLAY': ':0', 10:45:49 INFO - 'HOME': '/home/cltbld', 10:45:49 INFO - 'LANG': 'en_US.UTF-8', 10:45:49 INFO - 'LANGUAGE': 'en_US:en', 10:45:49 INFO - 'LOGNAME': 'cltbld', 10:45:49 INFO - 'MAIL': '/var/mail/cltbld', 10:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:49 INFO - 'MOZ_NO_REMOTE': '1', 10:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:49 INFO - 'NO_EM_RESTART': '1', 10:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:49 INFO - 'PWD': '/builds/slave/test', 10:45:49 INFO - 'SHELL': '/bin/bash', 10:45:49 INFO - 'SHLVL': '1', 10:45:49 INFO - 'TERM': 'linux', 10:45:49 INFO - 'TMOUT': '86400', 10:45:49 INFO - 'USER': 'cltbld', 10:45:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:49 INFO - '_': '/tools/buildbot/bin/python'} 10:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 INFO - Cleaning up... 10:45:49 INFO - Return code: 0 10:45:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:45:49 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')]} 10:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:49 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')]} 10:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:49 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 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:49 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 10:45:49 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 10:45:49 INFO - Using env: {'DISPLAY': ':0', 10:45:49 INFO - 'HOME': '/home/cltbld', 10:45:49 INFO - 'LANG': 'en_US.UTF-8', 10:45:49 INFO - 'LANGUAGE': 'en_US:en', 10:45:49 INFO - 'LOGNAME': 'cltbld', 10:45:49 INFO - 'MAIL': '/var/mail/cltbld', 10:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:49 INFO - 'MOZ_NO_REMOTE': '1', 10:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:49 INFO - 'NO_EM_RESTART': '1', 10:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:49 INFO - 'PWD': '/builds/slave/test', 10:45:49 INFO - 'SHELL': '/bin/bash', 10:45:49 INFO - 'SHLVL': '1', 10:45:49 INFO - 'TERM': 'linux', 10:45:49 INFO - 'TMOUT': '86400', 10:45:49 INFO - 'USER': 'cltbld', 10:45:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:49 INFO - '_': '/tools/buildbot/bin/python'} 10:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:45:49 INFO - Cleaning up... 10:45:49 INFO - Return code: 0 10:45:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:45:49 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')]} 10:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:49 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')]} 10:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:49 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ad3a77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a50350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, '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': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', '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 10:45:49 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', 'flake8'] in /builds/slave/test/build 10:45:49 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 flake8 10:45:49 INFO - Using env: {'DISPLAY': ':0', 10:45:49 INFO - 'HOME': '/home/cltbld', 10:45:49 INFO - 'LANG': 'en_US.UTF-8', 10:45:49 INFO - 'LANGUAGE': 'en_US:en', 10:45:49 INFO - 'LOGNAME': 'cltbld', 10:45:49 INFO - 'MAIL': '/var/mail/cltbld', 10:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:49 INFO - 'MOZ_NO_REMOTE': '1', 10:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:49 INFO - 'NO_EM_RESTART': '1', 10:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:49 INFO - 'PWD': '/builds/slave/test', 10:45:49 INFO - 'SHELL': '/bin/bash', 10:45:49 INFO - 'SHLVL': '1', 10:45:49 INFO - 'TERM': 'linux', 10:45:49 INFO - 'TMOUT': '86400', 10:45:49 INFO - 'USER': 'cltbld', 10:45:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:49 INFO - '_': '/tools/buildbot/bin/python'} 10:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:49 INFO - Downloading/unpacking flake8 10:45:49 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 10:45:49 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 10:45:49 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 10:45:49 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 10:45:49 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 10:45:49 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 10:45:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:45:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:45:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:45:52 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 10:45:52 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 10:45:52 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 10:45:52 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 10:45:52 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 10:45:52 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 10:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:45:52 INFO - no previously-included directories found matching 'docs/_build' 10:45:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:45:52 INFO - Running setup.py install for pep8 10:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:45:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:45:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:45:52 INFO - no previously-included directories found matching 'docs/_build' 10:45:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:45:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:45:52 INFO - Cleaning up... 10:45:52 INFO - Return code: 0 10:45:52 INFO - Running post-action listener: _resource_record_post_action 10:45:52 INFO - Running post-action listener: _start_resource_monitoring 10:45:52 INFO - Starting resource monitoring. 10:45:52 INFO - ##### 10:45:52 INFO - ##### Finished create-virtualenv step (success) 10:45:52 INFO - ##### 10:45:52 INFO - ##### 10:45:52 INFO - ##### Running install step. 10:45:52 INFO - ##### 10:45:52 INFO - Running pre-action listener: _resource_record_pre_action 10:45:52 INFO - Running main action method: install 10:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:52 INFO - Reading from file tmpfile_stdout 10:45:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:45:53 INFO - Reading from file tmpfile_stdout 10:45:53 INFO - Output received: 10:45:53 INFO - Usage: mozinstall [options] installer 10:45:53 INFO - Options: 10:45:53 INFO - -h, --help show this help message and exit 10:45:53 INFO - -d DEST, --destination=DEST 10:45:53 INFO - Directory to install application into. [default: 10:45:53 INFO - "/builds/slave/test"] 10:45:53 INFO - --app=APP Application being installed. [default: firefox] 10:45:53 INFO - mkdir: /builds/slave/test/build/application 10:45:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:46:08 INFO - Reading from file tmpfile_stdout 10:46:08 INFO - Output received: 10:46:08 INFO - /builds/slave/test/build/application/firefox/firefox 10:46:08 INFO - Running post-action listener: _resource_record_post_action 10:46:08 INFO - ##### 10:46:08 INFO - ##### Finished install step (success) 10:46:08 INFO - ##### 10:46:08 INFO - ##### 10:46:08 INFO - ##### Running run-tests step. 10:46:08 INFO - ##### 10:46:08 INFO - Running pre-action listener: _resource_record_pre_action 10:46:08 INFO - Running main action method: run_tests 10:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:46:08 INFO - Python 2.7.3 10:46:08 INFO - Return code: 0 10:46:08 INFO - grabbing minidump binary from tooltool 10:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:08 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 0x1adf1c0>, '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 0x1ae00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:46:08 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 10:46:08 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 10:46:08 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 10:46:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:46:09 INFO - Return code: 0 10:46:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:46:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:46:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:46:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:46:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:46:09 INFO - Return code: 0 10:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 10:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 10:46:09 INFO - Using env: {'DISPLAY': ':0', 10:46:09 INFO - 'HOME': '/home/cltbld', 10:46:09 INFO - 'LANG': 'en_US.UTF-8', 10:46:09 INFO - 'LANGUAGE': 'en_US:en', 10:46:09 INFO - 'LOGNAME': 'cltbld', 10:46:09 INFO - 'MAIL': '/var/mail/cltbld', 10:46:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:46:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:09 INFO - 'MOZ_NO_REMOTE': '1', 10:46:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:09 INFO - 'NO_EM_RESTART': '1', 10:46:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:09 INFO - 'PWD': '/builds/slave/test', 10:46:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:46:09 INFO - 'SHELL': '/bin/bash', 10:46:09 INFO - 'SHLVL': '1', 10:46:09 INFO - 'TERM': 'linux', 10:46:09 INFO - 'TMOUT': '86400', 10:46:09 INFO - 'USER': 'cltbld', 10:46:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160', 10:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:09 INFO - '_': '/tools/buildbot/bin/python'} 10:46:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 10:46:10 INFO - mozversion application_buildid: 20160721073519 10:46:10 INFO - mozversion application_changeset: 661d3548825aff461b50901da7ec5e32a8366bf4 10:46:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:46:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:46:10 INFO - mozversion application_name: Firefox 10:46:10 INFO - mozversion application_remotingname: firefox-dev 10:46:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:46:10 INFO - mozversion application_vendor: Mozilla 10:46:10 INFO - mozversion application_version: 49.0a2 10:46:10 INFO - mozversion platform_buildid: 20160721073519 10:46:10 INFO - mozversion platform_changeset: 661d3548825aff461b50901da7ec5e32a8366bf4 10:46:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:46:10 INFO - mozversion platform_version: 49.0a2 10:46:10 INFO - using testdate: 1469123170 10:46:10 INFO - actual date: 1469123170 10:46:10 INFO - starting webserver on 'localhost:55031' 10:46:10 INFO - SUITE-START | Running 2 tests 10:46:10 INFO - TEST-START | dromaeo_css 10:46:10 INFO - operating with platform_type : linux_ 10:46:10 INFO - Initialising browser for dromaeo_css test... 10:46:10 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf1xO0m/profile http://localhost:55031/getInfo.html) 10:46:14 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 10:46:14 INFO - PROCESS | 1666 | colorDepth:24 10:46:14 INFO - PROCESS | 1666 | Browser inner width/height: 1024/697 10:46:14 INFO - PROCESS | 1666 | __metrics 10:46:15 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:46:16 INFO - TEST-INFO | 1666: exit 0 10:46:16 INFO - Browser initialized. 10:46:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:46:16 INFO - TEST-INFO | started process 1794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf1xO0m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:28 INFO - PROCESS | 1794 | RSS: Main: 155791360 10:46:28 INFO - PROCESS | 1794 | 10:47:17 INFO - PROCESS | 1794 | 1469123237872 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] 10:49:25 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:55031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55031/tests/dromaeo/cssquery-ext.html) 10:49:27 INFO - PROCESS | 1794 | RSS: Main: 160722944 10:49:27 INFO - PROCESS | 1794 | 10:52:28 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:55031/tests/dromaeo/cssquery-ext.html (next: http://localhost:55031/tests/dromaeo/cssquery-jquery.html) 10:52:29 INFO - PROCESS | 1794 | RSS: Main: 157573120 10:52:29 INFO - PROCESS | 1794 | 10:55:31 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:55031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55031/tests/dromaeo/cssquery-mootools.html) 10:55:31 INFO - PROCESS | 1794 | RSS: Main: 157073408 10:55:31 INFO - PROCESS | 1794 | 10:58:33 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:55031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55031/tests/dromaeo/cssquery-prototype.html) 10:58:34 INFO - PROCESS | 1794 | RSS: Main: 156696576 10:58:34 INFO - PROCESS | 1794 | 11:01:36 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:55031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55031/tests/dromaeo/cssquery-yui.html) 11:01:37 INFO - PROCESS | 1794 | RSS: Main: 158543872 11:01:37 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:55031/tests/dromaeo/cssquery-yui.html (next: http://localhost:55031/tests/dromaeo/cssquery-dojo.html) 11:04:39 INFO - PROCESS | 1794 | RSS: Main: 158457856 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | __start_tp_report 11:04:39 INFO - PROCESS | 1794 | _x_x_mozilla_page_load 11:04:39 INFO - PROCESS | 1794 | _x_x_mozilla_page_load_details 11:04:39 INFO - PROCESS | 1794 | |i|pagename|runs| 11:04:39 INFO - PROCESS | 1794 | |0;dojo.html;3357.815320157391;3391.423458012137;3398.8470518826666;3400.217949871531;3423.281110966697;5579.7489112989915;5589.357223919251;5592.356878958916;5626.2967129108865;5626.409227031164;5649.435056494349;5650.943490565093;5696.401877802833;5712.800051998181;5733.569982251337;5109.080365534202;5148.536631703146;5167.870803229912;5204.817831375903;5213.087709650815;5088.033273678007;5123.4108077571;5157.3811142662935;5221.451747566508;5261.947380526203;5097.617678674096;5178.715170665612;5180.171172612383;5190.896182076356;5198.220266959948;5244.580433565306;5250.527452529291;5251.658642188284;5252.317198764155;5253.054450199001;4997.6501644884875;5018.64869459138;5028.899422011539;5091.1090559152;5114.539691427789;5479.835604931858;5498.670079795225;5522.779088836442;5525.060739674265;5534.086875665551;5978.581499295051;5993.101034844764;5999.880002399927;6008.369121242294;6013.729382177812;5942.049272116484;5981;6003.489703375219;6010.308814486346;6034.849128771772;5679.346875109374;5693.430656934315;5699.515541178963;5710.885782284331;5718.857028574319;6194.163787888668;6195;6199.845003874849;6227.470664993436;6233.3143354231;5768.682722450221;5947.910781338197;5959.493443057302;6002.129691194839;6034.818955431344;6065.5754097212775;6096.908546371808;6113;6115.868564315616;6120.663363515049;5909.3204281507315;6013.067974463965;6074.392560743979;6082.543809214327;6082.817515474543;5956.880862382728;5981.192539007266;5995.370486098984;6012.579119461596;6037.034074548052;4618.330342100444;4629.8148074077335;4644.140833945731;4655.906881862344;4673.228917228687;4117.402976568381;4131.256373852735;4146.606072423115;4163.292240319153;4175.8956026099595;5673.574481913791;5717.885642287131;5776.884462310814;5841.503472204825;5881.852953676193;6078.179445774764;6084.452399283997;6096.72564734588;6098.908516372258;6099.115628233882;5676;5817.534597232211;5878;5892.175095486636;5893.705314734246;5118.769655365518;5169.147090729987;5170.302009228706;5177.456367081402;5194.4026436959475;6342.968285158545;6347.238331400169;6357.586756860789;6365.267994180728;6383.968080159662;5993.6403815769445;6109.419605137505;6115.877682446415;6123.693815309306;6140.907886381798;6298.716557755004;6316.936830631818;6351.650659213788;6447.580907241015;6452.6128432292335;6017.247844019497;6031.095335699505;6039.305479869696;6061.242344706911;6077;5910.054391297372;6058.5153187745755;6147;6161.938380616137;6178.845528861814;5923.378045305181;5959.73181206838;5996.280446346466;6002.969985150046;6027.18632984559;5980.820575382745;5990.400959903975;5990.820275391571;5992.520598352208;5994.880102398015;5741.5119714824705;5795.623284486495;5812.389699081705;5882.058870580687;5896.115582662635;5967.7911273106965;5982.700864956648;6010.609310394811;6012.488938440107;6051;5917.289925209003;5917.467427931335;5918.852028699317;5920.348761636303;5931.822045338647 11:04:39 INFO - PROCESS | 1794 | |1;ext.html;597.1281928384558;646.5538778243013;653.5555822041016;660.0857811930478;666.883295423301;45735.627931162075;47016.52983470164;47017.764911175436;47064.99999999991;51742;49061.75469122658;49228.75385623076;49483;49538.25692614614;49627;9136.314776391764;9280.72157835266;9286.30352723545;9288.024757400477;9331.766705832375;9093.727188184364;9161.496117713523;9168.174864262215;9168.495732734697;9168.908310916871;9232.769180770467;9270.11933866285;9278.072192780735;9280.489573073479;9299.349045566812;9185.770355741093;9193.862092068624;9200.30997675177;9236.67671631493;9248.167664910123;9129.497877616728;9151.405158664666;9218.815623687557;9220.354575179741;9234.584443700049;44161.558384416065;44476;44536.3319550207;44541.55458445406;44547.77726111381;3673.081729567608;3686.3733165361955;3696.1868388954385;3761.4545890845948;4043;34246.31507369839;35078.82460587706;35128.82435587806;35212.47181292283;35298.82350588257;4521.007481843689;4561.589456948857;4588.770561471913;4608.422699501929;4634.490206077328;377553;381653;382287;383098;383594;65776;65809;65982;66201.33798661952;66298.66850665715;35854.46218306728;36058.819705901304;61135.694321528106;61844.38155618476;61993.380066199665;19689.409317720492;19941.800581994285;19993.400197994084;20085.39743807688;20119.0946407412;14898.627534311512;15061.623459413602;15062.548123556311;15105.54683359501;15195.240237988057;21394.251201207884;21639.45901352479;21650.24224152147;21719.56560868774;21785.34643960652;7509.51188172767;7514.549127052394;7677.654505547263;7787.805304867424;7907.920920790719;1049.9685009449577;1129.8926601972798;1158.3511937397097;1197.144042009967;1209.0750575809514;33877.416388461585;33985.32029359399;33986.49020264698;34428.31143377118;34690.132746681535;1162;1162.5698491558007;1172.2380452705809;1222.6576558563615;1289.278004317585;17990.91004544995;18046.548836278937;18143.818561814478;18153.45539633813;18505;588962;596491;596768;633863;1017142;67714;68296;68610;68725.31274687189;68893.65553172202;1471.7792331150413;1482.1181397068942;1485.6137404274966;1495.244901324824;1510.3958416633434;33960.83019584886;34050.829745851115;34141;34178;34494.65505345015;57587.71206143942;57744.13383799163;57796.71101644465;57895.421045789;58153.4184658148;408541;418111;418154;418888;422750;31079.378412432077;31203.37593248077;31446.371072577964;31558.526622100228;31699.20751981219;51437.48562514327;51469;51700;52774;52934;42537.78731106449;43348;43562.56437435712;44269.11461770682;45218.77390613026;43032.78483607687;43556.56443435652;43843;44362.55637443713;44725;42839.3574096395;44000;44666.776666116464;44730.10539789121;48166.5183348162;38762.418563721;39091.804540977115;39372;39613;39766;29928.70071299259;30004.84997574998;30150;30661.846690766404;30676.079717608507 11:04:39 INFO - PROCESS | 1794 | |2;jquery.html;422.75691477400494;428.4644194756554;431.4240488947255;433.91755566442373;440.58364845221257;18527;19492.317768878092;19941.900290498546;20934.476638084056;20945.05747241374;19332.710009349837;19340.323088691865;19834.90082549589;20074.895880726555;20081.297154599593;5620.409856965021;5748.2527271454655;5815.447532484428;5819.476247137757;5844.26946631671;5592.944070559303;5778.191053252548;5790.7104644767805;5812.622179558336;5868.706564671771;5725.742341594618;5733.598648094635;5740.397258287882;5768.250127483442;5789.189513468097;5524.8342549723575;5693.743781529821;5700.6579605223615;5720.942790572082;5734.283214598176;5160.277561141405;5165.096108181053;5174.741262936838;5178.766955487012;5197.948020519784;22972.54054918909;24065.278041658603;24122.758772412228;24336;24343.878280608482;2182.1162429216033;2435.232901635979;2482.2677310193535;2532.6580911576884;2540.1236573382153;10634.893651063468;11306.717332066683;12734.299613521252;15198.544043678707;15533;1974.427416049344;1992.163291417608;2133.3599920024085;2188.7471360909685;2189.0477642225683;55107.72446137784;63909.36090639081;89739.55130224307;92778;98968.01031989732;18726.438206853818;18765.81234187668;18836.529086772665;18985.33551325697;19290.324838630582;34119.31761364759;34261.486077708854;34300.31399372048;34334.656653433645;34469.48295775565;10838.132949364031;11050.944745276383;11232;11244.437778111062;11335.943320283346;9325.253979681609;9371.62513499466;9483.90516094844;9542.570584323723;9584.089511496397;9366.267240560519;9432.434053956784;9486;9726.902730972599;9804.215662746963;3570.6429357064085;3643.617420170844;3763.34141525232;3799.7150213733526;3816.5610954740005;1017.003336729994;1029.3669393323053;1052.6157952347337;1063.2982231727024;1116.5868628607468;19382.70925936112;19396.612067758848;19953.20187192496;19957.900210498854;20166.29417970364;1053.5996321397972;1058.8147074261974;1063.5798859450474;1083.664064140119;1084.3656460970262;9048.773780655536;10918.836217456745;11066;11066.667999960015;11117.833232501518;585383;606096;609497;616727;625648;61971.69014154991;88322;94715.52642236745;95258.04741952631;103924.48037759763;995.7560397702609;1121.7980763462492;1126.8366086917515;1136.7953768321781;1142.1205671632797;18364.806287591266;18370.540736481697;18645.533861653024;18663.346782862536;19075.90462047681;42015.7899210502;42366.57633423626;42956.78521607372;43202.35196472118;43939.56060439355;56461.15308270297;59970.10044849418;61220.69389653023;61737.69131154315;61957.38042619696;9046.592903319235;9254.213391861498;9281.39670921388;9321.906780932104;9420.481873497023;9844.556994935389;13844.723105538034;13891;13903.374348154559;14407;12177.208481448677;12180.939095304468;12231.75536489283;12462.563810266598;12941.158824676366;11906.345151016778;11960.76078478443;12097.2136811107;12304.446299916704;12477;11923.807619238007;12147.57483488109;12271.141020128505;12523.436445360163;12790.232586044867;8026.317762989977;9326.440413575207;9388.108129727665;9531.809363812823;9696.22430205596;9162.587683554122;12239.204451710966;12244.081693873173;12279.386030698608;12330.568430105262 11:04:39 INFO - PROCESS | 1794 | |3;mootools.html;1566.8405380018785;1622.8863979521432;1778.599815041615;1893.3278686066456;1923.134589434753;8542.273906717937;9326.673566425177;9454.85817712735;10048.397096174234;10051.195904327655;9442.386244894076;9711.854322185172;9749.951250243757;9797.069278418556;9818.067283608047;2464.716557595877;2480.987595062022;2492.3021553964827;2498.3254521279246;2500.224930271622;2450.5956517174645;2526.393665520271;2536.2771610091127;2545.5672535668887;2547.1594373856674;2443.7922776564014;2445.7065152181763;2469.3579669286023;2482.8386154899963;2495.226479791261;2402.2913240594066;2411.2404592553376;2421.794147497465;2473.95052098957;2475.987620061906;2397.460571371445;2439.865807380593;2441.6215486599604;2468.666729991446;2468.962965555518;9685.225181985425;9724.222062235074;9758.609655613767;9769.120779129913;9780.804383912282;5505.504504594565;5609.1305847593685;5636.661800291955;5667;5680.886382272372;3449.9482507762405;3494.4059509883127;3559.697425718817;3567.4827150063356;3603.621619729943;1292.0826213388411;1314.1326724361875;1319.808627748971;1330.6340756292;1342.080674737798;13865.09876858011;13871;13913;13950.511732089328;13960.162390256617;5061.7975280989085;5068.746562671926;5226.686398816083;5243.8164664236565;5252.29094072303;11622.825657615143;11748.765024699458;11756.470958806874;11785.528578856922;11789.705257368634;5794.015017447045;5839.182514447981;5843.386444423274;5851.853703657443;5876.118582212703;4622.699524530962;5078.898422031539;5240.161574148195;5241.50205730455;5286.762095705702;4369.868903932887;4399.1641588098155;4504.09918016398;4521.321801729767;4528.0943811237885;1317.8782160721232;1337.4716986790359;1339.9196048237136;1346.7373862096797;1358.2325985817981;1077.175960390302;1092.2736380307165;1103.4593049405732;1115.6931843742873;1124.1175677093443;6470.450011749054;6602.86794264112;6672.332766723289;6744.089547911068;6768.492363072789;480.5098799224771;1065.8880817514205;1139.4986206069468;1168.9064874809994;1172.6599286206904;4637.188492013952;4639.420072490939;4643.187442197669;4695;4703.506131856106;11977.760444791229;12280.754384912252;12282.692932676755;12345.691357716129;12356.25862448238;11936.104792140624;12256.754864902652;12263.202891812003;12270.81593776094;12294.262344259194;8824.161704638049;8942.68700595476;9208.723738287863;9218.400803947588;9235.399699019677;6696.83257918556;6760.729570817112;6831.59010459374;6882.483813713891;6941.652917354213;11116.944415277872;11169.497372618414;11251.606193783178;11376.94311528437;11422.200445969034;11463.484143213409;11564.306141631529;11589.768204636028;11645.941770291094;11659.591914282959;8410.453320534145;8574.22831945128;8644.740657780276;8782.648694052423;8812.735617931472;9389.953050234704;9614.663486778209;9637.42175469474;9659.227261819178;9694.418334899929;8399.49603023796;8627.827443451222;8801.163889430494;8858.025617182233;8892.73321800347;8499.320054395757;8514;8541.53021583819;8556.315494760529;8740.388172827841;7771.4559980800805;7839.216078392115;7876.212378762078;7905.881411778943;7915.208479152038;5571.3592936811165;5572.080606699849;5647.407022262768;5858.2677165354335;5865.530757539302;5595.916061259166;5683.687397193194;5891.734871930687;5928.614640048383;5984.341722410619 11:04:39 INFO - PROCESS | 1794 | |4;prototype.html;335.71967407214976;346.48892882997575;348.67921512208767;350.224253278987;355.13701704857203;5596.356419011815;5656;5723.627964182325;5810.15752715856;5810.912836307453;5701.429857014296;5706.629069110505;5706.828795136143;5707.14392841074;5720.1991721159075;4439.178751930887;4450.065486247891;4496.4829044659955;4503.932441013388;4508.188526065307;4408.853698038517;4480.641548676098;4487.551244875503;4489.663275254353;4492.438445194351;4399.18615056214;4400.911981760363;4426.136903303857;4467.798949047301;4487.326900964848;4476.261416866213;4477.597016268535;4501.144782491317;4507.346434766941;4511.278195488739;3874.612538746131;3991.355038267834;3994.1612261424843;4017.4576432181575;4041.8787436376956;5463.180522921593;5472.945270547283;5476.835694929158;5523.6685798851795;5526.47498487647;5156.9742151289;5159.446074193261;5161.896762064775;5178.844634660966;5195.480451954812;5589.04986152351;5959.510122469383;5962.373950735154;6016.939830601682;6041.24484439445;4287.121140166259;4316.287812510932;4320.265554855682;4324.200022995756;4336.891577710582;6141.662208578527;6182.69086545671;6184.969075154595;6195.597286176384;6201.193844800192;4346.7609281489185;4379.934300985487;4392;4404.889877753082;4411.779411029435;4444.266695995189;4456.22016147173;4459.1304695584695;4464.084862603158;4474.843380481668;5057.887264801738;5063.341765570526;5074.797008119708;5085.389753229562;5095.87260318495;5759.884802303931;5791.942080579141;5919.792807251725;5924.940750592439;6031.638101713911;1518.5596177108737;1525.2297589717123;1541.8535239152263;1544.5829626000916;1544.7605621128744;966.990330096704;971.7327734872966;976.9560369783377;982.3761911186448;985.3890587835588;5222.164453687467;5234.842954711365;5243.659162154448;5254.947450525522;5258;5414.620976531605;5426.538744206708;5436.673799572039;5437.564994800407;5463.96184724901;5029.371328583927;5151.304573882478;5226.346706661668;5240.790368385222;5266.999270138662;2899.6810350861388;2901.7098290170816;2912.606798082274;2917.7374036336405;2931.0327591894625;5644.463775941279;5666.46168613981;5746.02317606008;5751.619611293259;5791.391903850119;5173.301604283449;5465.72671366438;5505.366882808448;5512.228288039678;5530.474604912527;5560.833175004756;5589.608727389043;5601.131824567117;5677.829665110054;5695.430456954355;5073.771680274471;5400.2709634200455;5456.59075569326;5461.836144915659;5468.507834294933;5318.97340513295;5348.652337598043;5351.785928562814;5413.485718856702;5440.727963601883;5659.54723622101;5721.771129154788;5742.712864356682;5770.2498675171955;5793.420657934173;4030.6170913763144;4075.551689314114;4080.285949958805;4407.735535867858;4411.338299255009;6064.120702498201;6075.362086980804;6129.417705317987;6129.662868542273;6169.598976066542;5946.28644562638;5984.700764961822;6026.849328766641;6031.763488484938;6059.6364218147055;5981.820545383645;6003.939960600338;6024.849378765566;6040.184575082308;6059.575829692056;5532.944670553243;5834.562407819346;5962.731677074629;5979.5814292999075;5998.700064996646;6053.243344581927;6076.210092687922;6104.175936248727;6120.846978825387;6137.110119032626;5561.5272701820795;5842.678652674143;5850.151727999331;5952.547522436889;5956.315023772322 11:04:39 INFO - PROCESS | 1794 | |5;yui.html;823.2878560045559;827.230675471811;872.6116877989294;898.7932775461644;920.7882187096964;13766.931165344171;15654.373825046985;15682.137482438462;15695.529134125994;15707.136107514083;14073.225972571505;14184.929075354634;14229.92885035576;14245.786313205284;14264.71470570588;705.0270626535387;844.4553263145268;849.235687880909;874.4185116897256;876.2201640539924;860.956952152393;863.6718047142077;866.9263112635433;868.2272777228272;868.2619773192798;926.0646746785727;931.6739141300525;932.4265576670333;932.5011119051309;933.8272419602396;908.1418059933399;920.2867777472512;921.5806807902421;924.1820988425225;926.9304802139867;678.2302087131093;678.2471456683078;679.6431873266525;680.9489288303397;682.3210905149358;14303.356348964322;14330.498432554914;14367.066140700925;14391.280435978264;14398.352074156688;15598.688026239524;15851.682966340724;15932.840671593252;15942.28259728315;15949.521514354472;11665.533378664843;11683.357415342152;11821.817818218195;12138.939305303506;12237.265764054186;4039.7778122203267;4042.130941847517;4075.4294398784195;4131.566185550534;4134.64855487284;76286.99999999945;76423;76523;77570.61214693947;77624;12409.503619855104;12449.25304481734;12551.3096779678;12554.43505042257;12623.684407889692;23837.7616223839;23889.880550597485;23918.521629567313;24164.51670966606;24657;9007.144321289466;9156.771080722901;9310.95344523273;9586.328956972944;9685.661001865043;5102.132637451642;5103.8468845934685;5157.922631160535;5241.68549887008;5359.866003349869;3539.911502212414;3651.561812582454;3673.265346930571;3674.210044840372;3677.356462619031;587.5886879184588;593.5133190783603;599.5353600959291;599.9730012149464;609.7774312375951;616.9481034835594;766.7086507127367;772.4284029817894;792.7344339646284;815.7552734179723;10077.344972576906;10322.329048611817;10450.581976720998;10476.47617619116;10488.741905459707;702.6732569355274;760.4258784617579;804.5655346113033;820.9122912141437;825.2449009156675;4652;4740.928886066712;4945.505449455098;4972.229304457743;4985.9750701246985;70686.64656676787;71636.283637164;71690;118228;119959;97139.51430242804;97610;98585;101226.4938675302;103579;88690;92088.53955730313;92142;92240;94663.52668236752;9190.816183676423;9360.625574976924;9370.906290937277;9389.29580281468;9423.528823558932;51969.480305197976;52586.47413525969;53322;53873;54478.455215447335;68484.31515684979;69530.65234673997;73983;74738.25261747313;76067;14714;15125.924370378078;15648.530544083696;15890;16181.919090404472;16272.3491060361;16734.83265167333;16852.410165644145;16896.639549343257;17110.572235694206;13835.336358649258;13931.721365572834;14078.155310681392;14223.431062757787;14464.855351446771;13963.371648275648;14170.787438188641;14262.144271343752;14356.06685565435;14537.200453975132;13436.664083397993;13565.728685426433;13699.315034248448;13807;13808.516701915385;12460.314682692539;12713.237205767684;13029.413676384396;13079.41142648564;13292.268925209206;11506.194566380273;11737.47181376823;11819.349935753617;11959.820602691141;12059.939700301442 11:04:39 INFO - PROCESS | 1794 | __end_tp_report 11:04:39 INFO - PROCESS | 1794 | __start_cc_report 11:04:39 INFO - PROCESS | 1794 | _x_x_mozilla_cycle_collect,351 11:04:39 INFO - PROCESS | 1794 | __end_cc_report 11:04:39 INFO - PROCESS | 1794 | __startTimestamp1469124279848__endTimestamp 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | ------- Summary: start ------- 11:04:39 INFO - PROCESS | 1794 | Number of tests: 6 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | [#0] dojo.html Cycles:165 Average:5646.43 Median:5910.05 stddev:636.36 (10.8%) stddev-sans-first:612.46 11:04:39 INFO - PROCESS | 1794 | Values: 3357.8 3391.4 3398.8 3400.2 3423.3 5579.7 5589.4 5592.4 5626.3 5626.4 5649.4 5650.9 5696.4 5712.8 5733.6 5109.1 5148.5 5167.9 5204.8 5213.1 5088.0 5123.4 5157.4 5221.5 5261.9 5097.6 5178.7 5180.2 5190.9 5198.2 5244.6 5250.5 5251.7 5252.3 5253.1 4997.7 5018.6 5028.9 5091.1 5114.5 5479.8 5498.7 5522.8 5525.1 5534.1 5978.6 5993.1 5999.9 6008.4 6013.7 5942.0 5981.0 6003.5 6010.3 6034.8 5679.3 5693.4 5699.5 5710.9 5718.9 6194.2 6195.0 6199.8 6227.5 6233.3 5768.7 5947.9 5959.5 6002.1 6034.8 6065.6 6096.9 6113.0 6115.9 6120.7 5909.3 6013.1 6074.4 6082.5 6082.8 5956.9 5981.2 5995.4 6012.6 6037.0 4618.3 4629.8 4644.1 4655.9 4673.2 4117.4 4131.3 4146.6 4163.3 4175.9 5673.6 5717.9 5776.9 5841.5 5881.9 6078.2 6084.5 6096.7 6098.9 6099.1 5676.0 5817.5 5878.0 5892.2 5893.7 5118.8 5169.1 5170.3 5177.5 5194.4 6343.0 6347.2 6357.6 6365.3 6384.0 5993.6 6109.4 6115.9 6123.7 6140.9 6298.7 6316.9 6351.7 6447.6 6452.6 6017.2 6031.1 6039.3 6061.2 6077.0 5910.1 6058.5 6147.0 6161.9 6178.8 5923.4 5959.7 5996.3 6003.0 6027.2 5980.8 5990.4 5990.8 5992.5 5994.9 5741.5 5795.6 5812.4 5882.1 5896.1 5967.8 5982.7 6010.6 6012.5 6051.0 5917.3 5917.5 5918.9 5920.3 5931.8 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | [#1] ext.html Cycles:180 Average:66701.05 Median:44080.78 stddev:139641.25 (316.8%) stddev-sans-first:139944.78 11:04:39 INFO - PROCESS | 1794 | Values: 597.1 646.6 653.6 660.1 666.9 45735.6 47016.5 47017.8 47065.0 51742.0 49061.8 49228.8 49483.0 49538.3 49627.0 9136.3 9280.7 9286.3 9288.0 9331.8 9093.7 9161.5 9168.2 9168.5 9168.9 9232.8 9270.1 9278.1 9280.5 9299.3 9185.8 9193.9 9200.3 9236.7 9248.2 9129.5 9151.4 9218.8 9220.4 9234.6 44161.6 44476.0 44536.3 44541.6 44547.8 3673.1 3686.4 3696.2 3761.5 4043.0 34246.3 35078.8 35128.8 35212.5 35298.8 4521.0 4561.6 4588.8 4608.4 4634.5 377553.0 381653.0 382287.0 383098.0 383594.0 65776.0 65809.0 65982.0 66201.3 66298.7 35854.5 36058.8 61135.7 61844.4 61993.4 19689.4 19941.8 19993.4 20085.4 20119.1 14898.6 15061.6 15062.5 15105.5 15195.2 21394.3 21639.5 21650.2 21719.6 21785.3 7509.5 7514.5 7677.7 7787.8 7907.9 1050.0 1129.9 1158.4 1197.1 1209.1 33877.4 33985.3 33986.5 34428.3 34690.1 1162.0 1162.6 1172.2 1222.7 1289.3 17990.9 18046.5 18143.8 18153.5 18505.0 588962.0 596491.0 596768.0 633863.0 1017142.0 67714.0 68296.0 68610.0 68725.3 68893.7 1471.8 1482.1 1485.6 1495.2 1510.4 33960.8 34050.8 34141.0 34178.0 34494.7 57587.7 57744.1 57796.7 57895.4 58153.4 408541.0 418111.0 418154.0 418888.0 422750.0 31079.4 31203.4 31446.4 31558.5 31699.2 51437.5 51469.0 51700.0 52774.0 52934.0 42537.8 43348.0 43562.6 44269.1 45218.8 43032.8 43556.6 43843.0 44362.6 44725.0 42839.4 44000.0 44666.8 44730.1 48166.5 38762.4 39091.8 39372.0 39613.0 39766.0 29928.7 30004.8 30150.0 30661.8 30676.1 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | [#2] jquery.html Cycles:180 Average:33615.66 Median:2536.39 stddev:99667.62 (3929.5%) stddev-sans-first:99916.05 11:04:39 INFO - PROCESS | 1794 | Values: 422.8 428.5 431.4 433.9 440.6 18527.0 19492.3 19941.9 20934.5 20945.1 19332.7 19340.3 19834.9 20074.9 20081.3 5620.4 5748.3 5815.4 5819.5 5844.3 5592.9 5778.2 5790.7 5812.6 5868.7 5725.7 5733.6 5740.4 5768.3 5789.2 5524.8 5693.7 5700.7 5720.9 5734.3 5160.3 5165.1 5174.7 5178.8 5197.9 22972.5 24065.3 24122.8 24336.0 24343.9 2182.1 2435.2 2482.3 2532.7 2540.1 10634.9 11306.7 12734.3 15198.5 15533.0 1974.4 1992.2 2133.4 2188.7 2189.0 55107.7 63909.4 89739.6 92778.0 98968.0 18726.4 18765.8 18836.5 18985.3 19290.3 34119.3 34261.5 34300.3 34334.7 34469.5 10838.1 11050.9 11232.0 11244.4 11335.9 9325.3 9371.6 9483.9 9542.6 9584.1 9366.3 9432.4 9486.0 9726.9 9804.2 3570.6 3643.6 3763.3 3799.7 3816.6 1017.0 1029.4 1052.6 1063.3 1116.6 19382.7 19396.6 19953.2 19957.9 20166.3 1053.6 1058.8 1063.6 1083.7 1084.4 9048.8 10918.8 11066.0 11066.7 11117.8 585383.0 606096.0 609497.0 616727.0 625648.0 61971.7 88322.0 94715.5 95258.0 103924.5 995.8 1121.8 1126.8 1136.8 1142.1 18364.8 18370.5 18645.5 18663.3 19075.9 42015.8 42366.6 42956.8 43202.4 43939.6 56461.2 59970.1 61220.7 61737.7 61957.4 9046.6 9254.2 9281.4 9321.9 9420.5 9844.6 13844.7 13891.0 13903.4 14407.0 12177.2 12180.9 12231.8 12462.6 12941.2 11906.3 11960.8 12097.2 12304.4 12477.0 11923.8 12147.6 12271.1 12523.4 12790.2 8026.3 9326.4 9388.1 9531.8 9696.2 9162.6 12239.2 12244.1 12279.4 12330.6 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | [#3] mootools.html Cycles:180 Average:6461.98 Median:4575.40 stddev:3728.98 (81.5%) stddev-sans-first:3721.30 11:04:39 INFO - PROCESS | 1794 | Values: 1566.8 1622.9 1778.6 1893.3 1923.1 8542.3 9326.7 9454.9 10048.4 10051.2 9442.4 9711.9 9750.0 9797.1 9818.1 2464.7 2481.0 2492.3 2498.3 2500.2 2450.6 2526.4 2536.3 2545.6 2547.2 2443.8 2445.7 2469.4 2482.8 2495.2 2402.3 2411.2 2421.8 2474.0 2476.0 2397.5 2439.9 2441.6 2468.7 2469.0 9685.2 9724.2 9758.6 9769.1 9780.8 5505.5 5609.1 5636.7 5667.0 5680.9 3449.9 3494.4 3559.7 3567.5 3603.6 1292.1 1314.1 1319.8 1330.6 1342.1 13865.1 13871.0 13913.0 13950.5 13960.2 5061.8 5068.7 5226.7 5243.8 5252.3 11622.8 11748.8 11756.5 11785.5 11789.7 5794.0 5839.2 5843.4 5851.9 5876.1 4622.7 5078.9 5240.2 5241.5 5286.8 4369.9 4399.2 4504.1 4521.3 4528.1 1317.9 1337.5 1339.9 1346.7 1358.2 1077.2 1092.3 1103.5 1115.7 1124.1 6470.5 6602.9 6672.3 6744.1 6768.5 480.5 1065.9 1139.5 1168.9 1172.7 4637.2 4639.4 4643.2 4695.0 4703.5 11977.8 12280.8 12282.7 12345.7 12356.3 11936.1 12256.8 12263.2 12270.8 12294.3 8824.2 8942.7 9208.7 9218.4 9235.4 6696.8 6760.7 6831.6 6882.5 6941.7 11116.9 11169.5 11251.6 11376.9 11422.2 11463.5 11564.3 11589.8 11645.9 11659.6 8410.5 8574.2 8644.7 8782.6 8812.7 9390.0 9614.7 9637.4 9659.2 9694.4 8399.5 8627.8 8801.2 8858.0 8892.7 8499.3 8514.0 8541.5 8556.3 8740.4 7771.5 7839.2 7876.2 7905.9 7915.2 5571.4 5572.1 5647.4 5858.3 5865.5 5595.9 5683.7 5891.7 5928.6 5984.3 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | [#4] prototype.html Cycles:180 Average:4867.12 Median:5439.15 stddev:1399.84 (25.7%) stddev-sans-first:1361.82 11:04:39 INFO - PROCESS | 1794 | Values: 335.7 346.5 348.7 350.2 355.1 5596.4 5656.0 5723.6 5810.2 5810.9 5701.4 5706.6 5706.8 5707.1 5720.2 4439.2 4450.1 4496.5 4503.9 4508.2 4408.9 4480.6 4487.6 4489.7 4492.4 4399.2 4400.9 4426.1 4467.8 4487.3 4476.3 4477.6 4501.1 4507.3 4511.3 3874.6 3991.4 3994.2 4017.5 4041.9 5463.2 5472.9 5476.8 5523.7 5526.5 5157.0 5159.4 5161.9 5178.8 5195.5 5589.0 5959.5 5962.4 6016.9 6041.2 4287.1 4316.3 4320.3 4324.2 4336.9 6141.7 6182.7 6185.0 6195.6 6201.2 4346.8 4379.9 4392.0 4404.9 4411.8 4444.3 4456.2 4459.1 4464.1 4474.8 5057.9 5063.3 5074.8 5085.4 5095.9 5759.9 5791.9 5919.8 5924.9 6031.6 1518.6 1525.2 1541.9 1544.6 1544.8 967.0 971.7 977.0 982.4 985.4 5222.2 5234.8 5243.7 5254.9 5258.0 5414.6 5426.5 5436.7 5437.6 5464.0 5029.4 5151.3 5226.3 5240.8 5267.0 2899.7 2901.7 2912.6 2917.7 2931.0 5644.5 5666.5 5746.0 5751.6 5791.4 5173.3 5465.7 5505.4 5512.2 5530.5 5560.8 5589.6 5601.1 5677.8 5695.4 5073.8 5400.3 5456.6 5461.8 5468.5 5319.0 5348.7 5351.8 5413.5 5440.7 5659.5 5721.8 5742.7 5770.2 5793.4 4030.6 4075.6 4080.3 4407.7 4411.3 6064.1 6075.4 6129.4 6129.7 6169.6 5946.3 5984.7 6026.8 6031.8 6059.6 5981.8 6003.9 6024.8 6040.2 6059.6 5532.9 5834.6 5962.7 5979.6 5998.7 6053.2 6076.2 6104.2 6120.8 6137.1 5561.5 5842.7 5850.2 5952.5 5956.3 11:04:39 INFO - PROCESS | 1794 | 11:04:39 INFO - PROCESS | 1794 | [#5] yui.html Cycles:180 Average:20724.26 Median:4843.22 stddev:28578.82 (590.1%) stddev-sans-first:28619.92 11:04:39 INFO - PROCESS | 1794 | Values: 823.3 827.2 872.6 898.8 920.8 13766.9 15654.4 15682.1 15695.5 15707.1 14073.2 14184.9 14229.9 14245.8 14264.7 705.0 844.5 849.2 874.4 876.2 861.0 863.7 866.9 868.2 868.3 926.1 931.7 932.4 932.5 933.8 908.1 920.3 921.6 924.2 926.9 678.2 678.2 679.6 680.9 682.3 14303.4 14330.5 14367.1 14391.3 14398.4 15598.7 15851.7 15932.8 15942.3 15949.5 11665.5 11683.4 11821.8 12138.9 12237.3 4039.8 4042.1 4075.4 4131.6 4134.6 76287.0 76423.0 76523.0 77570.6 77624.0 12409.5 12449.3 12551.3 12554.4 12623.7 23837.8 23889.9 23918.5 24164.5 24657.0 9007.1 9156.8 9311.0 9586.3 9685.7 5102.1 5103.8 5157.9 5241.7 5359.9 3539.9 3651.6 3673.3 3674.2 3677.4 587.6 593.5 599.5 600.0 609.8 616.9 766.7 772.4 792.7 815.8 10077.3 10322.3 10450.6 10476.5 10488.7 702.7 760.4 804.6 820.9 825.2 4652.0 4740.9 4945.5 4972.2 4986.0 70686.6 71636.3 71690.0 118228.0 119959.0 97139.5 97610.0 98585.0 101226.5 103579.0 88690.0 92088.5 92142.0 92240.0 94663.5 9190.8 9360.6 9370.9 9389.3 9423.5 51969.5 52586.5 53322.0 53873.0 54478.5 68484.3 69530.7 73983.0 74738.3 76067.0 14714.0 15125.9 15648.5 15890.0 16181.9 16272.3 16734.8 16852.4 16896.6 17110.6 13835.3 13931.7 14078.2 14223.4 14464.9 13963.4 14170.8 14262.1 14356.1 14537.2 13436.7 13565.7 13699.3 13807.0 13808.5 12460.3 12713.2 13029.4 13079.4 13292.3 11506.2 11737.5 11819.3 11959.8 12059.9 11:04:39 INFO - PROCESS | 1794 | -------- Summary: end -------- 11:04:39 INFO - PROCESS | 1794 | 11:04:40 INFO - TEST-INFO | 1794: exit 0 11:04:40 INFO - TEST-OK | dromaeo_css | took 1110412ms 11:04:40 INFO - TEST-START | kraken 11:04:40 INFO - operating with platform_type : linux_ 11:04:40 INFO - Initialising browser for kraken test... 11:04:40 INFO - TEST-INFO | started process 2049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPuXU2A/profile http://localhost:55031/getInfo.html) 11:04:45 INFO - PROCESS | 2049 | __metrics Screen width/height:1600/1200 11:04:45 INFO - PROCESS | 2049 | colorDepth:24 11:04:45 INFO - PROCESS | 2049 | Browser inner width/height: 1024/697 11:04:45 INFO - PROCESS | 2049 | __metrics 11:04:46 ERROR - PROCESS | 2049 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:04:46 INFO - TEST-INFO | 2049: exit 0 11:04:46 INFO - Browser initialized. 11:04:46 INFO - Running cycle 1/1 for kraken test... 11:04:46 INFO - TEST-INFO | started process 2177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPuXU2A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:58 INFO - PROCESS | 2177 | RSS: Main: 156811264 11:04:58 INFO - PROCESS | 2177 | 11:05:01 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55031/tests/kraken/driver.html?testName=audio-beat-detection) 11:05:02 INFO - PROCESS | 2177 | RSS: Main: 161730560 11:05:02 INFO - PROCESS | 2177 | 11:05:04 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55031/tests/kraken/driver.html?testName=audio-dft) 11:05:05 INFO - PROCESS | 2177 | RSS: Main: 160841728 11:05:05 INFO - PROCESS | 2177 | 11:05:08 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55031/tests/kraken/driver.html?testName=audio-fft) 11:05:08 INFO - PROCESS | 2177 | RSS: Main: 161714176 11:05:08 INFO - PROCESS | 2177 | 11:05:10 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55031/tests/kraken/driver.html?testName=audio-oscillator) 11:05:11 INFO - PROCESS | 2177 | RSS: Main: 161312768 11:05:11 INFO - PROCESS | 2177 | 11:05:13 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:05:14 INFO - PROCESS | 2177 | RSS: Main: 161300480 11:05:14 INFO - PROCESS | 2177 | 11:05:17 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55031/tests/kraken/driver.html?testName=imaging-darkroom) 11:05:18 INFO - PROCESS | 2177 | RSS: Main: 160702464 11:05:18 INFO - PROCESS | 2177 | 11:05:21 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55031/tests/kraken/driver.html?testName=imaging-desaturate) 11:05:22 INFO - PROCESS | 2177 | RSS: Main: 161263616 11:05:22 INFO - PROCESS | 2177 | 11:05:24 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55031/tests/kraken/driver.html?testName=json-parse-financial) 11:05:25 INFO - PROCESS | 2177 | RSS: Main: 160956416 11:05:25 INFO - PROCESS | 2177 | 11:05:27 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:05:27 INFO - PROCESS | 2177 | RSS: Main: 160763904 11:05:27 INFO - PROCESS | 2177 | 11:05:29 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:05:30 INFO - PROCESS | 2177 | RSS: Main: 160776192 11:05:30 INFO - PROCESS | 2177 | 11:05:32 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:05:32 INFO - PROCESS | 2177 | RSS: Main: 162066432 11:05:32 INFO - PROCESS | 2177 | 11:05:35 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:05:35 INFO - PROCESS | 2177 | RSS: Main: 161853440 11:05:35 INFO - PROCESS | 2177 | 11:05:38 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:05:39 INFO - PROCESS | 2177 | RSS: Main: 161923072 11:05:39 INFO - PROCESS | 2177 | 11:05:40 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:55031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55031/tests/kraken/driver.html?testName=ai-astar) 11:05:41 INFO - PROCESS | 2177 | RSS: Main: 162463744 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | __start_tp_report 11:05:41 INFO - PROCESS | 2177 | _x_x_mozilla_page_load 11:05:41 INFO - PROCESS | 2177 | _x_x_mozilla_page_load_details 11:05:41 INFO - PROCESS | 2177 | |i|pagename|runs| 11:05:41 INFO - PROCESS | 2177 | |0;ai-astar;113;104;112;111;112;110;109;111;110;110 11:05:41 INFO - PROCESS | 2177 | |1;audio-beat-detection;161;126;153;179;135;148;154;134;182;126 11:05:41 INFO - PROCESS | 2177 | |2;audio-dft;165;164;161;164;162;163;161;163;162;162 11:05:41 INFO - PROCESS | 2177 | |3;audio-fft;74;75;75;190;76;75;75;74;171;76 11:05:41 INFO - PROCESS | 2177 | |4;audio-oscillator;85;84;151;83;84;85;142;86;84;142 11:05:41 INFO - PROCESS | 2177 | |5;imaging-gaussian-blur;117;117;118;117;117;119;118;118;117;117 11:05:41 INFO - PROCESS | 2177 | |6;imaging-darkroom;148;148;147;146;146;147;147;146;146;148 11:05:41 INFO - PROCESS | 2177 | |7;imaging-desaturate;96;95;97;95;95;100;95;96;95;95 11:05:41 INFO - PROCESS | 2177 | |8;json-parse-financial;54;51;53;51;54;51;52;56;52;51 11:05:41 INFO - PROCESS | 2177 | |9;json-stringify-tinderbox;60;61;60;62;64;61;61;61;65;61 11:05:41 INFO - PROCESS | 2177 | |10;stanford-crypto-aes;76;77;83;82;81;78;83;83;105;78 11:05:41 INFO - PROCESS | 2177 | |11;stanford-crypto-ccm;117;123;128;118;115;124;128;120;129;133 11:05:41 INFO - PROCESS | 2177 | |12;stanford-crypto-pbkdf2;154;154;164;150;157;159;152;149;155;155 11:05:41 INFO - PROCESS | 2177 | |13;stanford-crypto-sha256-iterative;62;61;61;64;60;61;60;64;60;62 11:05:41 INFO - PROCESS | 2177 | __end_tp_report 11:05:41 INFO - PROCESS | 2177 | __start_cc_report 11:05:41 INFO - PROCESS | 2177 | _x_x_mozilla_cycle_collect,884 11:05:41 INFO - PROCESS | 2177 | __end_cc_report 11:05:41 INFO - PROCESS | 2177 | __startTimestamp1469124341049__endTimestamp 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | ------- Summary: start ------- 11:05:41 INFO - PROCESS | 2177 | Number of tests: 14 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.49 (2.2%) stddev-sans-first:2.42 11:05:41 INFO - PROCESS | 2177 | Values: 113.0 104.0 112.0 111.0 112.0 110.0 109.0 111.0 110.0 110.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:153.50 stddev:20.13 (13.1%) stddev-sans-first:20.94 11:05:41 INFO - PROCESS | 2177 | Values: 161.0 126.0 153.0 179.0 135.0 148.0 154.0 134.0 182.0 126.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.13 11:05:41 INFO - PROCESS | 2177 | Values: 165.0 164.0 161.0 164.0 162.0 163.0 161.0 163.0 162.0 162.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#3] audio-fft Cycles:10 Average:96.10 Median:75.00 stddev:44.71 (59.6%) stddev-sans-first:46.70 11:05:41 INFO - PROCESS | 2177 | Values: 74.0 75.0 75.0 190.0 76.0 75.0 75.0 74.0 171.0 76.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.00 stddev:29.37 (35.0%) stddev-sans-first:30.46 11:05:41 INFO - PROCESS | 2177 | Values: 85.0 84.0 151.0 83.0 84.0 85.0 142.0 86.0 84.0 142.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 11:05:41 INFO - PROCESS | 2177 | Values: 117.0 117.0 118.0 117.0 117.0 119.0 118.0 118.0 117.0 117.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 11:05:41 INFO - PROCESS | 2177 | Values: 148.0 148.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 148.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:1.60 (1.7%) stddev-sans-first:1.69 11:05:41 INFO - PROCESS | 2177 | Values: 96.0 95.0 97.0 95.0 95.0 100.0 95.0 96.0 95.0 95.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:1.72 (3.3%) stddev-sans-first:1.73 11:05:41 INFO - PROCESS | 2177 | Values: 54.0 51.0 53.0 51.0 54.0 51.0 52.0 56.0 52.0 51.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.65 (2.7%) stddev-sans-first:1.64 11:05:41 INFO - PROCESS | 2177 | Values: 60.0 61.0 60.0 62.0 64.0 61.0 61.0 61.0 65.0 61.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:81.50 stddev:8.32 (10.2%) stddev-sans-first:8.47 11:05:41 INFO - PROCESS | 2177 | Values: 76.0 77.0 83.0 82.0 81.0 78.0 83.0 83.0 105.0 78.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:126.00 stddev:5.95 (4.7%) stddev-sans-first:5.83 11:05:41 INFO - PROCESS | 2177 | Values: 117.0 123.0 128.0 118.0 115.0 124.0 128.0 120.0 129.0 133.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:4.38 (2.8%) stddev-sans-first:4.64 11:05:41 INFO - PROCESS | 2177 | Values: 154.0 154.0 164.0 150.0 157.0 159.0 152.0 149.0 155.0 155.0 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - PROCESS | 2177 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.51 (2.5%) stddev-sans-first:1.59 11:05:41 INFO - PROCESS | 2177 | Values: 62.0 61.0 61.0 64.0 60.0 61.0 60.0 64.0 60.0 62.0 11:05:41 INFO - PROCESS | 2177 | -------- Summary: end -------- 11:05:41 INFO - PROCESS | 2177 | 11:05:41 INFO - TEST-INFO | 2177: exit 0 11:05:42 INFO - TEST-OK | kraken | took 61439ms 11:05:42 INFO - SUITE-END | took 1171s 11:05:42 INFO - Completed test suite (00:19:32) 11:05:42 INFO - javascript benchmark 11:05:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7821.853270912773, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.815320157391, 3391.423458012137, 3398.8470518826666, 3400.217949871531, 3423.281110966697, 5579.7489112989915, 5589.357223919251, 5592.356878958916, 5626.2967129108865, 5626.409227031164, 5649.435056494349, 5650.943490565093, 5696.401877802833, 5712.800051998181, 5733.569982251337, 5109.080365534202, 5148.536631703146, 5167.870803229912, 5204.817831375903, 5213.087709650815, 5088.033273678007, 5123.4108077571, 5157.3811142662935, 5221.451747566508, 5261.947380526203, 5097.617678674096, 5178.715170665612, 5180.171172612383, 5190.896182076356, 5198.220266959948, 5244.580433565306, 5250.527452529291, 5251.658642188284, 5252.317198764155, 5253.054450199001, 4997.6501644884875, 5018.64869459138, 5028.899422011539, 5091.1090559152, 5114.539691427789, 5479.835604931858, 5498.670079795225, 5522.779088836442, 5525.060739674265, 5534.086875665551, 5978.581499295051, 5993.101034844764, 5999.880002399927, 6008.369121242294, 6013.729382177812, 5942.049272116484, 5981.0, 6003.489703375219, 6010.308814486346, 6034.849128771772, 5679.346875109374, 5693.430656934315, 5699.515541178963, 5710.885782284331, 5718.857028574319, 6194.163787888668, 6195.0, 6199.845003874849, 6227.470664993436, 6233.3143354231, 5768.682722450221, 5947.910781338197, 5959.493443057302, 6002.129691194839, 6034.818955431344, 6065.5754097212775, 6096.908546371808, 6113.0, 6115.868564315616, 6120.663363515049, 5909.3204281507315, 6013.067974463965, 6074.392560743979, 6082.543809214327, 6082.817515474543, 5956.880862382728, 5981.192539007266, 5995.370486098984, 6012.579119461596, 6037.034074548052, 4618.330342100444, 4629.8148074077335, 4644.140833945731, 4655.906881862344, 4673.228917228687, 4117.402976568381, 4131.256373852735, 4146.606072423115, 4163.292240319153, 4175.8956026099595, 5673.574481913791, 5717.885642287131, 5776.884462310814, 5841.503472204825, 5881.852953676193, 6078.179445774764, 6084.452399283997, 6096.72564734588, 6098.908516372258, 6099.115628233882, 5676.0, 5817.534597232211, 5878.0, 5892.175095486636, 5893.705314734246, 5118.769655365518, 5169.147090729987, 5170.302009228706, 5177.456367081402, 5194.4026436959475, 6342.968285158545, 6347.238331400169, 6357.586756860789, 6365.267994180728, 6383.968080159662, 5993.6403815769445, 6109.419605137505, 6115.877682446415, 6123.693815309306, 6140.907886381798, 6298.716557755004, 6316.936830631818, 6351.650659213788, 6447.580907241015, 6452.6128432292335, 6017.247844019497, 6031.095335699505, 6039.305479869696, 6061.242344706911, 6077.0, 5910.054391297372, 6058.5153187745755, 6147.0, 6161.938380616137, 6178.845528861814, 5923.378045305181, 5959.73181206838, 5996.280446346466, 6002.969985150046, 6027.18632984559, 5980.820575382745, 5990.400959903975, 5990.820275391571, 5992.520598352208, 5994.880102398015, 5741.5119714824705, 5795.623284486495, 5812.389699081705, 5882.058870580687, 5896.115582662635, 5967.7911273106965, 5982.700864956648, 6010.609310394811, 6012.488938440107, 6051.0, 5917.289925209003, 5917.467427931335, 5918.852028699317, 5920.348761636303, 5931.822045338647], "value": 5604.462305061112, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1281928384558, 646.5538778243013, 653.5555822041016, 660.0857811930478, 666.883295423301, 45735.627931162075, 47016.52983470164, 47017.764911175436, 47064.99999999991, 51742.0, 49061.75469122658, 49228.75385623076, 49483.0, 49538.25692614614, 49627.0, 9136.314776391764, 9280.72157835266, 9286.30352723545, 9288.024757400477, 9331.766705832375, 9093.727188184364, 9161.496117713523, 9168.174864262215, 9168.495732734697, 9168.908310916871, 9232.769180770467, 9270.11933866285, 9278.072192780735, 9280.489573073479, 9299.349045566812, 9185.770355741093, 9193.862092068624, 9200.30997675177, 9236.67671631493, 9248.167664910123, 9129.497877616728, 9151.405158664666, 9218.815623687557, 9220.354575179741, 9234.584443700049, 44161.558384416065, 44476.0, 44536.3319550207, 44541.55458445406, 44547.77726111381, 3673.081729567608, 3686.3733165361955, 3696.1868388954385, 3761.4545890845948, 4043.0, 34246.31507369839, 35078.82460587706, 35128.82435587806, 35212.47181292283, 35298.82350588257, 4521.007481843689, 4561.589456948857, 4588.770561471913, 4608.422699501929, 4634.490206077328, 377553.0, 381653.0, 382287.0, 383098.0, 383594.0, 65776.0, 65809.0, 65982.0, 66201.33798661952, 66298.66850665715, 35854.46218306728, 36058.819705901304, 61135.694321528106, 61844.38155618476, 61993.380066199665, 19689.409317720492, 19941.800581994285, 19993.400197994084, 20085.39743807688, 20119.0946407412, 14898.627534311512, 15061.623459413602, 15062.548123556311, 15105.54683359501, 15195.240237988057, 21394.251201207884, 21639.45901352479, 21650.24224152147, 21719.56560868774, 21785.34643960652, 7509.51188172767, 7514.549127052394, 7677.654505547263, 7787.805304867424, 7907.920920790719, 1049.9685009449577, 1129.8926601972798, 1158.3511937397097, 1197.144042009967, 1209.0750575809514, 33877.416388461585, 33985.32029359399, 33986.49020264698, 34428.31143377118, 34690.132746681535, 1162.0, 1162.5698491558007, 1172.2380452705809, 1222.6576558563615, 1289.278004317585, 17990.91004544995, 18046.548836278937, 18143.818561814478, 18153.45539633813, 18505.0, 588962.0, 596491.0, 596768.0, 633863.0, 1017142.0, 67714.0, 68296.0, 68610.0, 68725.31274687189, 68893.65553172202, 1471.7792331150413, 1482.1181397068942, 1485.6137404274966, 1495.244901324824, 1510.3958416633434, 33960.83019584886, 34050.829745851115, 34141.0, 34178.0, 34494.65505345015, 57587.71206143942, 57744.13383799163, 57796.71101644465, 57895.421045789, 58153.4184658148, 408541.0, 418111.0, 418154.0, 418888.0, 422750.0, 31079.378412432077, 31203.37593248077, 31446.371072577964, 31558.526622100228, 31699.20751981219, 51437.48562514327, 51469.0, 51700.0, 52774.0, 52934.0, 42537.78731106449, 43348.0, 43562.56437435712, 44269.11461770682, 45218.77390613026, 43032.78483607687, 43556.56443435652, 43843.0, 44362.55637443713, 44725.0, 42839.3574096395, 44000.0, 44666.776666116464, 44730.10539789121, 48166.5183348162, 38762.418563721, 39091.804540977115, 39372.0, 39613.0, 39766.0, 29928.70071299259, 30004.84997574998, 30150.0, 30661.846690766404, 30676.079717608507], "value": 21775.618446573095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.75691477400494, 428.4644194756554, 431.4240488947255, 433.91755566442373, 440.58364845221257, 18527.0, 19492.317768878092, 19941.900290498546, 20934.476638084056, 20945.05747241374, 19332.710009349837, 19340.323088691865, 19834.90082549589, 20074.895880726555, 20081.297154599593, 5620.409856965021, 5748.2527271454655, 5815.447532484428, 5819.476247137757, 5844.26946631671, 5592.944070559303, 5778.191053252548, 5790.7104644767805, 5812.622179558336, 5868.706564671771, 5725.742341594618, 5733.598648094635, 5740.397258287882, 5768.250127483442, 5789.189513468097, 5524.8342549723575, 5693.743781529821, 5700.6579605223615, 5720.942790572082, 5734.283214598176, 5160.277561141405, 5165.096108181053, 5174.741262936838, 5178.766955487012, 5197.948020519784, 22972.54054918909, 24065.278041658603, 24122.758772412228, 24336.0, 24343.878280608482, 2182.1162429216033, 2435.232901635979, 2482.2677310193535, 2532.6580911576884, 2540.1236573382153, 10634.893651063468, 11306.717332066683, 12734.299613521252, 15198.544043678707, 15533.0, 1974.427416049344, 1992.163291417608, 2133.3599920024085, 2188.7471360909685, 2189.0477642225683, 55107.72446137784, 63909.36090639081, 89739.55130224307, 92778.0, 98968.01031989732, 18726.438206853818, 18765.81234187668, 18836.529086772665, 18985.33551325697, 19290.324838630582, 34119.31761364759, 34261.486077708854, 34300.31399372048, 34334.656653433645, 34469.48295775565, 10838.132949364031, 11050.944745276383, 11232.0, 11244.437778111062, 11335.943320283346, 9325.253979681609, 9371.62513499466, 9483.90516094844, 9542.570584323723, 9584.089511496397, 9366.267240560519, 9432.434053956784, 9486.0, 9726.902730972599, 9804.215662746963, 3570.6429357064085, 3643.617420170844, 3763.34141525232, 3799.7150213733526, 3816.5610954740005, 1017.003336729994, 1029.3669393323053, 1052.6157952347337, 1063.2982231727024, 1116.5868628607468, 19382.70925936112, 19396.612067758848, 19953.20187192496, 19957.900210498854, 20166.29417970364, 1053.5996321397972, 1058.8147074261974, 1063.5798859450474, 1083.664064140119, 1084.3656460970262, 9048.773780655536, 10918.836217456745, 11066.0, 11066.667999960015, 11117.833232501518, 585383.0, 606096.0, 609497.0, 616727.0, 625648.0, 61971.69014154991, 88322.0, 94715.52642236745, 95258.04741952631, 103924.48037759763, 995.7560397702609, 1121.7980763462492, 1126.8366086917515, 1136.7953768321781, 1142.1205671632797, 18364.806287591266, 18370.540736481697, 18645.533861653024, 18663.346782862536, 19075.90462047681, 42015.7899210502, 42366.57633423626, 42956.78521607372, 43202.35196472118, 43939.56060439355, 56461.15308270297, 59970.10044849418, 61220.69389653023, 61737.69131154315, 61957.38042619696, 9046.592903319235, 9254.213391861498, 9281.39670921388, 9321.906780932104, 9420.481873497023, 9844.556994935389, 13844.723105538034, 13891.0, 13903.374348154559, 14407.0, 12177.208481448677, 12180.939095304468, 12231.75536489283, 12462.563810266598, 12941.158824676366, 11906.345151016778, 11960.76078478443, 12097.2136811107, 12304.446299916704, 12477.0, 11923.807619238007, 12147.57483488109, 12271.141020128505, 12523.436445360163, 12790.232586044867, 8026.317762989977, 9326.440413575207, 9388.108129727665, 9531.809363812823, 9696.22430205596, 9162.587683554122, 12239.204451710966, 12244.081693873173, 12279.386030698608, 12330.568430105262], "value": 10455.326860114646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.8405380018785, 1622.8863979521432, 1778.599815041615, 1893.3278686066456, 1923.134589434753, 8542.273906717937, 9326.673566425177, 9454.85817712735, 10048.397096174234, 10051.195904327655, 9442.386244894076, 9711.854322185172, 9749.951250243757, 9797.069278418556, 9818.067283608047, 2464.716557595877, 2480.987595062022, 2492.3021553964827, 2498.3254521279246, 2500.224930271622, 2450.5956517174645, 2526.393665520271, 2536.2771610091127, 2545.5672535668887, 2547.1594373856674, 2443.7922776564014, 2445.7065152181763, 2469.3579669286023, 2482.8386154899963, 2495.226479791261, 2402.2913240594066, 2411.2404592553376, 2421.794147497465, 2473.95052098957, 2475.987620061906, 2397.460571371445, 2439.865807380593, 2441.6215486599604, 2468.666729991446, 2468.962965555518, 9685.225181985425, 9724.222062235074, 9758.609655613767, 9769.120779129913, 9780.804383912282, 5505.504504594565, 5609.1305847593685, 5636.661800291955, 5667.0, 5680.886382272372, 3449.9482507762405, 3494.4059509883127, 3559.697425718817, 3567.4827150063356, 3603.621619729943, 1292.0826213388411, 1314.1326724361875, 1319.808627748971, 1330.6340756292, 1342.080674737798, 13865.09876858011, 13871.0, 13913.0, 13950.511732089328, 13960.162390256617, 5061.7975280989085, 5068.746562671926, 5226.686398816083, 5243.8164664236565, 5252.29094072303, 11622.825657615143, 11748.765024699458, 11756.470958806874, 11785.528578856922, 11789.705257368634, 5794.015017447045, 5839.182514447981, 5843.386444423274, 5851.853703657443, 5876.118582212703, 4622.699524530962, 5078.898422031539, 5240.161574148195, 5241.50205730455, 5286.762095705702, 4369.868903932887, 4399.1641588098155, 4504.09918016398, 4521.321801729767, 4528.0943811237885, 1317.8782160721232, 1337.4716986790359, 1339.9196048237136, 1346.7373862096797, 1358.2325985817981, 1077.175960390302, 1092.2736380307165, 1103.4593049405732, 1115.6931843742873, 1124.1175677093443, 6470.450011749054, 6602.86794264112, 6672.332766723289, 6744.089547911068, 6768.492363072789, 480.5098799224771, 1065.8880817514205, 1139.4986206069468, 1168.9064874809994, 1172.6599286206904, 4637.188492013952, 4639.420072490939, 4643.187442197669, 4695.0, 4703.506131856106, 11977.760444791229, 12280.754384912252, 12282.692932676755, 12345.691357716129, 12356.25862448238, 11936.104792140624, 12256.754864902652, 12263.202891812003, 12270.81593776094, 12294.262344259194, 8824.161704638049, 8942.68700595476, 9208.723738287863, 9218.400803947588, 9235.399699019677, 6696.83257918556, 6760.729570817112, 6831.59010459374, 6882.483813713891, 6941.652917354213, 11116.944415277872, 11169.497372618414, 11251.606193783178, 11376.94311528437, 11422.200445969034, 11463.484143213409, 11564.306141631529, 11589.768204636028, 11645.941770291094, 11659.591914282959, 8410.453320534145, 8574.22831945128, 8644.740657780276, 8782.648694052423, 8812.735617931472, 9389.953050234704, 9614.663486778209, 9637.42175469474, 9659.227261819178, 9694.418334899929, 8399.49603023796, 8627.827443451222, 8801.163889430494, 8858.025617182233, 8892.73321800347, 8499.320054395757, 8514.0, 8541.53021583819, 8556.315494760529, 8740.388172827841, 7771.4559980800805, 7839.216078392115, 7876.212378762078, 7905.881411778943, 7915.208479152038, 5571.3592936811165, 5572.080606699849, 5647.407022262768, 5858.2677165354335, 5865.530757539302, 5595.916061259166, 5683.687397193194, 5891.734871930687, 5928.614640048383, 5984.341722410619], "value": 5137.253098719329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.71967407214976, 346.48892882997575, 348.67921512208767, 350.224253278987, 355.13701704857203, 5596.356419011815, 5656.0, 5723.627964182325, 5810.15752715856, 5810.912836307453, 5701.429857014296, 5706.629069110505, 5706.828795136143, 5707.14392841074, 5720.1991721159075, 4439.178751930887, 4450.065486247891, 4496.4829044659955, 4503.932441013388, 4508.188526065307, 4408.853698038517, 4480.641548676098, 4487.551244875503, 4489.663275254353, 4492.438445194351, 4399.18615056214, 4400.911981760363, 4426.136903303857, 4467.798949047301, 4487.326900964848, 4476.261416866213, 4477.597016268535, 4501.144782491317, 4507.346434766941, 4511.278195488739, 3874.612538746131, 3991.355038267834, 3994.1612261424843, 4017.4576432181575, 4041.8787436376956, 5463.180522921593, 5472.945270547283, 5476.835694929158, 5523.6685798851795, 5526.47498487647, 5156.9742151289, 5159.446074193261, 5161.896762064775, 5178.844634660966, 5195.480451954812, 5589.04986152351, 5959.510122469383, 5962.373950735154, 6016.939830601682, 6041.24484439445, 4287.121140166259, 4316.287812510932, 4320.265554855682, 4324.200022995756, 4336.891577710582, 6141.662208578527, 6182.69086545671, 6184.969075154595, 6195.597286176384, 6201.193844800192, 4346.7609281489185, 4379.934300985487, 4392.0, 4404.889877753082, 4411.779411029435, 4444.266695995189, 4456.22016147173, 4459.1304695584695, 4464.084862603158, 4474.843380481668, 5057.887264801738, 5063.341765570526, 5074.797008119708, 5085.389753229562, 5095.87260318495, 5759.884802303931, 5791.942080579141, 5919.792807251725, 5924.940750592439, 6031.638101713911, 1518.5596177108737, 1525.2297589717123, 1541.8535239152263, 1544.5829626000916, 1544.7605621128744, 966.990330096704, 971.7327734872966, 976.9560369783377, 982.3761911186448, 985.3890587835588, 5222.164453687467, 5234.842954711365, 5243.659162154448, 5254.947450525522, 5258.0, 5414.620976531605, 5426.538744206708, 5436.673799572039, 5437.564994800407, 5463.96184724901, 5029.371328583927, 5151.304573882478, 5226.346706661668, 5240.790368385222, 5266.999270138662, 2899.6810350861388, 2901.7098290170816, 2912.606798082274, 2917.7374036336405, 2931.0327591894625, 5644.463775941279, 5666.46168613981, 5746.02317606008, 5751.619611293259, 5791.391903850119, 5173.301604283449, 5465.72671366438, 5505.366882808448, 5512.228288039678, 5530.474604912527, 5560.833175004756, 5589.608727389043, 5601.131824567117, 5677.829665110054, 5695.430456954355, 5073.771680274471, 5400.2709634200455, 5456.59075569326, 5461.836144915659, 5468.507834294933, 5318.97340513295, 5348.652337598043, 5351.785928562814, 5413.485718856702, 5440.727963601883, 5659.54723622101, 5721.771129154788, 5742.712864356682, 5770.2498675171955, 5793.420657934173, 4030.6170913763144, 4075.551689314114, 4080.285949958805, 4407.735535867858, 4411.338299255009, 6064.120702498201, 6075.362086980804, 6129.417705317987, 6129.662868542273, 6169.598976066542, 5946.28644562638, 5984.700764961822, 6026.849328766641, 6031.763488484938, 6059.6364218147055, 5981.820545383645, 6003.939960600338, 6024.849378765566, 6040.184575082308, 6059.575829692056, 5532.944670553243, 5834.562407819346, 5962.731677074629, 5979.5814292999075, 5998.700064996646, 6053.243344581927, 6076.210092687922, 6104.175936248727, 6120.846978825387, 6137.110119032626, 5561.5272701820795, 5842.678652674143, 5850.151727999331, 5952.547522436889, 5956.315023772322], "value": 4419.874781500259, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.2878560045559, 827.230675471811, 872.6116877989294, 898.7932775461644, 920.7882187096964, 13766.931165344171, 15654.373825046985, 15682.137482438462, 15695.529134125994, 15707.136107514083, 14073.225972571505, 14184.929075354634, 14229.92885035576, 14245.786313205284, 14264.71470570588, 705.0270626535387, 844.4553263145268, 849.235687880909, 874.4185116897256, 876.2201640539924, 860.956952152393, 863.6718047142077, 866.9263112635433, 868.2272777228272, 868.2619773192798, 926.0646746785727, 931.6739141300525, 932.4265576670333, 932.5011119051309, 933.8272419602396, 908.1418059933399, 920.2867777472512, 921.5806807902421, 924.1820988425225, 926.9304802139867, 678.2302087131093, 678.2471456683078, 679.6431873266525, 680.9489288303397, 682.3210905149358, 14303.356348964322, 14330.498432554914, 14367.066140700925, 14391.280435978264, 14398.352074156688, 15598.688026239524, 15851.682966340724, 15932.840671593252, 15942.28259728315, 15949.521514354472, 11665.533378664843, 11683.357415342152, 11821.817818218195, 12138.939305303506, 12237.265764054186, 4039.7778122203267, 4042.130941847517, 4075.4294398784195, 4131.566185550534, 4134.64855487284, 76286.99999999945, 76423.0, 76523.0, 77570.61214693947, 77624.0, 12409.503619855104, 12449.25304481734, 12551.3096779678, 12554.43505042257, 12623.684407889692, 23837.7616223839, 23889.880550597485, 23918.521629567313, 24164.51670966606, 24657.0, 9007.144321289466, 9156.771080722901, 9310.95344523273, 9586.328956972944, 9685.661001865043, 5102.132637451642, 5103.8468845934685, 5157.922631160535, 5241.68549887008, 5359.866003349869, 3539.911502212414, 3651.561812582454, 3673.265346930571, 3674.210044840372, 3677.356462619031, 587.5886879184588, 593.5133190783603, 599.5353600959291, 599.9730012149464, 609.7774312375951, 616.9481034835594, 766.7086507127367, 772.4284029817894, 792.7344339646284, 815.7552734179723, 10077.344972576906, 10322.329048611817, 10450.581976720998, 10476.47617619116, 10488.741905459707, 702.6732569355274, 760.4258784617579, 804.5655346113033, 820.9122912141437, 825.2449009156675, 4652.0, 4740.928886066712, 4945.505449455098, 4972.229304457743, 4985.9750701246985, 70686.64656676787, 71636.283637164, 71690.0, 118228.0, 119959.0, 97139.51430242804, 97610.0, 98585.0, 101226.4938675302, 103579.0, 88690.0, 92088.53955730313, 92142.0, 92240.0, 94663.52668236752, 9190.816183676423, 9360.625574976924, 9370.906290937277, 9389.29580281468, 9423.528823558932, 51969.480305197976, 52586.47413525969, 53322.0, 53873.0, 54478.455215447335, 68484.31515684979, 69530.65234673997, 73983.0, 74738.25261747313, 76067.0, 14714.0, 15125.924370378078, 15648.530544083696, 15890.0, 16181.919090404472, 16272.3491060361, 16734.83265167333, 16852.410165644145, 16896.639549343257, 17110.572235694206, 13835.336358649258, 13931.721365572834, 14078.155310681392, 14223.431062757787, 14464.855351446771, 13963.371648275648, 14170.787438188641, 14262.144271343752, 14356.06685565435, 14537.200453975132, 13436.664083397993, 13565.728685426433, 13699.315034248448, 13807.0, 13808.516701915385, 12460.314682692539, 12713.237205767684, 13029.413676384396, 13079.41142648564, 13292.268925209206, 11506.194566380273, 11737.47181376823, 11819.349935753617, 11959.820602691141, 12059.939700301442], "value": 7903.717821038499, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 112.0, 111.0, 112.0, 110.0, 109.0, 111.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 153.0, 179.0, 135.0, 148.0, 154.0, 134.0, 182.0, 126.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 161.0, 164.0, 162.0, 163.0, 161.0, 163.0, 162.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 190.0, 76.0, 75.0, 75.0, 74.0, 171.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 151.0, 83.0, 84.0, 85.0, 142.0, 86.0, 84.0, 142.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 100.0, 95.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 53.0, 51.0, 54.0, 51.0, 52.0, 56.0, 52.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 62.0, 64.0, 61.0, 61.0, 61.0, 65.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 83.0, 82.0, 81.0, 78.0, 83.0, 83.0, 105.0, 78.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 123.0, 128.0, 118.0, 115.0, 124.0, 128.0, 120.0, 129.0, 133.0], "value": 123.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 164.0, 150.0, 157.0, 159.0, 152.0, 149.0, 155.0, 155.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 64.0, 60.0, 61.0, 60.0, 64.0, 60.0, 62.0], "value": 61.5, "unit": "score"}]}]} 11:05:42 INFO - Return code: 0 11:05:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:05:42 ERROR - # TBPL SUCCESS # 11:05:42 INFO - Running post-action listener: _resource_record_post_action 11:05:42 INFO - ##### 11:05:42 INFO - ##### Finished run-tests step (success) 11:05:42 INFO - ##### 11:05:42 INFO - Running post-run listener: _resource_record_post_run 11:05:42 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 503177216; Read time: 304; Write time: 474080 11:05:42 INFO - TinderboxPrint: CPU usage
13.5% 11:05:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 304 11:05:42 INFO - TinderboxPrint: I/O write bytes / time
503,177,216 / 474,080 11:05:42 INFO - TinderboxPrint: CPU idle
8,208.8 (86.5%) 11:05:42 INFO - TinderboxPrint: CPU user
1,219.2 (12.9%) 11:05:42 INFO - TinderboxPrint: Swap in / out
0 / 0 11:05:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252616704; Read time: 0; Write time: 277400 11:05:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250560512; Read time: 304; Write time: 196680 11:05:42 INFO - Running post-run listener: _upload_blobber_files 11:05:42 INFO - Blob upload gear active. 11:05:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:05:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:05:42 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:05:42 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:05:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:05:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:05:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:44 INFO - (blobuploader) - INFO - Done attempting. 11:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:45 INFO - (blobuploader) - INFO - Done attempting. 11:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:06:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:07 INFO - (blobuploader) - INFO - Done attempting. 11:06:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:06:07 INFO - Return code: 0 11:06:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:06:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:06:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e90109bfe8310989c21a52538509f8dd5524ffffd09e41637b3bda85de71a6d94a7aa442b98d125b302fc6935e77641cb5dc8617a1538b3824a190a7925bfce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b68d767a78b34a92ab469451e0c9daff51982b8624f62706dd3e1b5d9f1afd5026ec0d8f17c9c9bd356e0fa4308c457bca2b94f48ff398b8dbc063c86029a1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5835fb811fde3fa5f8d6fac608d1d51ddebe65da2b88e388b3d0a263335531172a5d57814b782ff8b6f0c323ab92cc5015c0aad2fae0495b5b88b5be1530a7df"} 11:06:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:06:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:06:07 INFO - Contents: 11:06:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e90109bfe8310989c21a52538509f8dd5524ffffd09e41637b3bda85de71a6d94a7aa442b98d125b302fc6935e77641cb5dc8617a1538b3824a190a7925bfce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b68d767a78b34a92ab469451e0c9daff51982b8624f62706dd3e1b5d9f1afd5026ec0d8f17c9c9bd356e0fa4308c457bca2b94f48ff398b8dbc063c86029a1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5835fb811fde3fa5f8d6fac608d1d51ddebe65da2b88e388b3d0a263335531172a5d57814b782ff8b6f0c323ab92cc5015c0aad2fae0495b5b88b5be1530a7df"} 11:06:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:06:07 INFO - Copying logs to upload dir... 11:06:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:06:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.887112 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-21 11:06:07.253885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 11:06:07.257728) ========= 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=fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160 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/Mozilla-Aurora/sha512/8e90109bfe8310989c21a52538509f8dd5524ffffd09e41637b3bda85de71a6d94a7aa442b98d125b302fc6935e77641cb5dc8617a1538b3824a190a7925bfce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b68d767a78b34a92ab469451e0c9daff51982b8624f62706dd3e1b5d9f1afd5026ec0d8f17c9c9bd356e0fa4308c457bca2b94f48ff398b8dbc063c86029a1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5835fb811fde3fa5f8d6fac608d1d51ddebe65da2b88e388b3d0a263335531172a5d57814b782ff8b6f0c323ab92cc5015c0aad2fae0495b5b88b5be1530a7df"} build_url:https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/IquNN92RQbK29ZBN3bgUsw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e90109bfe8310989c21a52538509f8dd5524ffffd09e41637b3bda85de71a6d94a7aa442b98d125b302fc6935e77641cb5dc8617a1538b3824a190a7925bfce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b68d767a78b34a92ab469451e0c9daff51982b8624f62706dd3e1b5d9f1afd5026ec0d8f17c9c9bd356e0fa4308c457bca2b94f48ff398b8dbc063c86029a1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5835fb811fde3fa5f8d6fac608d1d51ddebe65da2b88e388b3d0a263335531172a5d57814b782ff8b6f0c323ab92cc5015c0aad2fae0495b5b88b5be1530a7df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 11:06:07.283428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:06:07.283801) ========= 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=fa44defc139c4ba8574fe040000001db-1469122494.701258-1469848160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:06:07.368256) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 11:06:07.368582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 11:06:07.368948) ========= ========= Total master_lag: 0.16 =========