builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1467107879.36 results: success (0) buildid: 20160628022621 builduid: e8d817ddb802471c8391a7adedf04dcc revision: 4db7a29c60ddf136d49d24d901c93b4acdfe664a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.360596) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.361650) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.362305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.382472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.383169) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 02:57:59-- 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% 41.4M=0s 2016-06-28 02:57:59 (41.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.513122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.513916) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:57:59.566313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 02:57:59.567113) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4db7a29c60ddf136d49d24d901c93b4acdfe664a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4db7a29c60ddf136d49d24d901c93b4acdfe664a --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=5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 02:58:00,022 truncating revision to first 12 chars 2016-06-28 02:58:00,022 Setting DEBUG logging. 2016-06-28 02:58:00,022 attempt 1/10 2016-06-28 02:58:00,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4db7a29c60dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 02:58:01,009 unpacking tar archive at: fx-team-4db7a29c60dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.324337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 02:58:00.907537) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:58:00.907923) ========= script_repo_revision: 4db7a29c60ddf136d49d24d901c93b4acdfe664a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:58:00.908411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:58:00.908762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:58:00.919959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-28 02:58:00.920387) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:01 INFO - MultiFileLogger online at 20160628 02:58:01 in /builds/slave/test 02:58:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:58:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:01 INFO - {'append_to_log': False, 02:58:01 INFO - 'base_work_dir': '/builds/slave/test', 02:58:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:58:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:01 INFO - 'branch': 'Fx-Team-Non-PGO', 02:58:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:01 INFO - 'config_files': ('talos/linux_config.py',), 02:58:01 INFO - 'default_actions': ('clobber', 02:58:01 INFO - 'read-buildbot-config', 02:58:01 INFO - 'download-and-extract', 02:58:01 INFO - 'populate-webroot', 02:58:01 INFO - 'create-virtualenv', 02:58:01 INFO - 'install', 02:58:01 INFO - 'run-tests'), 02:58:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:01 INFO - 'download_minidump_stackwalk': True, 02:58:01 INFO - 'download_symbols': 'ondemand', 02:58:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:01 INFO - 'installer_path': 'installer.exe', 02:58:01 INFO - 'log_level': 'info', 02:58:01 INFO - 'log_name': 'talos', 02:58:01 INFO - 'log_to_console': True, 02:58:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:01 INFO - 'opt_config_files': (), 02:58:01 INFO - 'pip_index': False, 02:58:01 INFO - 'sps_profile': False, 02:58:01 INFO - 'sps_profile_interval': 0, 02:58:01 INFO - 'suite': 'dromaeojs-e10s', 02:58:01 INFO - 'system_bits': '32', 02:58:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:01 INFO - 'title': 'talos-linux64-ix-039', 02:58:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:01 INFO - 'use_talos_json': True, 02:58:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:01 INFO - 'work_dir': 'build'} 02:58:01 INFO - ##### 02:58:01 INFO - ##### Running clobber step. 02:58:01 INFO - ##### 02:58:01 INFO - Running pre-action listener: _resource_record_pre_action 02:58:01 INFO - Running main action method: clobber 02:58:01 INFO - rmtree: /builds/slave/test/build 02:58:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:01 INFO - Running post-action listener: _resource_record_post_action 02:58:01 INFO - ##### 02:58:01 INFO - ##### Finished clobber step (success) 02:58:01 INFO - ##### 02:58:01 INFO - ##### 02:58:01 INFO - ##### Running read-buildbot-config step. 02:58:01 INFO - ##### 02:58:01 INFO - Running pre-action listener: _resource_record_pre_action 02:58:01 INFO - Running main action method: read_buildbot_config 02:58:01 INFO - Using buildbot properties: 02:58:01 INFO - { 02:58:01 INFO - "project": "", 02:58:01 INFO - "product": "firefox", 02:58:01 INFO - "script_repo_revision": "production", 02:58:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:58:01 INFO - "repository": "", 02:58:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:58:01 INFO - "buildid": "20160628022621", 02:58:01 INFO - "pgo_build": "False", 02:58:01 INFO - "basedir": "/builds/slave/test", 02:58:01 INFO - "buildnumber": 1390, 02:58:01 INFO - "slavename": "talos-linux64-ix-039", 02:58:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:58:01 INFO - "platform": "ubuntu64_hw", 02:58:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:58:01 INFO - "branch": "fx-team", 02:58:01 INFO - "repo_path": "integration/fx-team", 02:58:01 INFO - "revision": "4db7a29c60ddf136d49d24d901c93b4acdfe664a", 02:58:01 INFO - "stage_platform": "linux64", 02:58:01 INFO - "builduid": "e8d817ddb802471c8391a7adedf04dcc", 02:58:01 INFO - "slavebuilddir": "test" 02:58:01 INFO - } 02:58:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:58:01 INFO - Running post-action listener: _resource_record_post_action 02:58:01 INFO - ##### 02:58:01 INFO - ##### Finished read-buildbot-config step (success) 02:58:01 INFO - ##### 02:58:01 INFO - ##### 02:58:01 INFO - ##### Running download-and-extract step. 02:58:01 INFO - ##### 02:58:01 INFO - Running pre-action listener: _resource_record_pre_action 02:58:01 INFO - Running main action method: download_and_extract 02:58:01 INFO - mkdir: /builds/slave/test/build/tests 02:58:01 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')]} 02:58:01 INFO - https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:58:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:58:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:58:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:58:03 INFO - Downloaded 1361 bytes. 02:58:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:58:03 INFO - Using the following test package requirements: 02:58:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:58:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:58:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:58:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'jsshell-linux-x86_64.zip'], 02:58:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:58:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:58:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:58:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:58:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:58:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:58:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:58:03 INFO - https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:58:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:58:04 INFO - Downloaded 22713809 bytes. 02:58:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:58:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:58:05 INFO - Return code: 0 02:58:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:05 INFO - https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:58:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:58:07 INFO - Downloaded 22713809 bytes. 02:58:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:58:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:58:08 INFO - Return code: 0 02:58: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')]} 02:58:08 INFO - https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:58:10 INFO - Downloaded 14405245 bytes. 02:58:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:58:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:58:10 INFO - Return code: 0 02:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:10 INFO - https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:58:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:58:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:58:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:58:12 INFO - Downloaded 56386764 bytes. 02:58:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:58:12 INFO - mkdir: /builds/slave/test/properties 02:58:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:58:12 INFO - Writing to file /builds/slave/test/properties/build_url 02:58:12 INFO - Contents: 02:58:12 INFO - build_url:https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:58:12 INFO - Running post-action listener: _resource_record_post_action 02:58:12 INFO - Running post-action listener: set_extra_try_arguments 02:58:12 INFO - ##### 02:58:12 INFO - ##### Finished download-and-extract step (success) 02:58:12 INFO - ##### 02:58:12 INFO - ##### 02:58:12 INFO - ##### Running populate-webroot step. 02:58:12 INFO - ##### 02:58:12 INFO - Running pre-action listener: _resource_record_pre_action 02:58:12 INFO - Running main action method: populate_webroot 02:58:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:58:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:58:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:58:12 INFO - '--tppagecycles', 02:58:12 INFO - '7'], 02:58:12 INFO - 'tests': ['tsvgm']}}, 02:58:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:58:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:58:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:58:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:58:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['damp', 'tps']}, 02:58:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'tests': ['damp', 'tps']}, 02:58:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['dromaeo_dom']}, 02:58:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:58:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['basic_compositor_video']}, 02:58:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:58:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['a11yr', 02:58:12 INFO - 'ts_paint', 02:58:12 INFO - 'tpaint', 02:58:12 INFO - 'sessionrestore', 02:58:12 INFO - 'sessionrestore_no_auto_restore', 02:58:12 INFO - 'tabpaint']}, 02:58:12 INFO - 'other-e10s': {'tests': ['a11yr', 02:58:12 INFO - 'ts_paint', 02:58:12 INFO - 'tpaint', 02:58:12 INFO - 'sessionrestore', 02:58:12 INFO - 'sessionrestore_no_auto_restore', 02:58:12 INFO - 'tabpaint']}, 02:58:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:58:12 INFO - 'ts_paint', 02:58:12 INFO - 'tpaint', 02:58:12 INFO - 'sessionrestore', 02:58:12 INFO - 'sessionrestore_no_auto_restore', 02:58:12 INFO - 'tabpaint']}, 02:58:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:58:12 INFO - 'ts_paint', 02:58:12 INFO - 'tpaint', 02:58:12 INFO - 'sessionrestore', 02:58:12 INFO - 'sessionrestore_no_auto_restore', 02:58:12 INFO - 'tabpaint']}, 02:58:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['a11yr', 02:58:12 INFO - 'ts_paint', 02:58:12 INFO - 'tpaint', 02:58:12 INFO - 'sessionrestore', 02:58:12 INFO - 'sessionrestore_no_auto_restore', 02:58:12 INFO - 'tabpaint']}, 02:58:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['a11yr', 02:58:12 INFO - 'ts_paint', 02:58:12 INFO - 'tpaint', 02:58:12 INFO - 'sessionrestore', 02:58:12 INFO - 'sessionrestore_no_auto_restore', 02:58:12 INFO - 'tabpaint']}, 02:58:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['tsvgx', 02:58:12 INFO - 'tsvgr_opacity', 02:58:12 INFO - 'tart', 02:58:12 INFO - 'tscrollx', 02:58:12 INFO - 'cart']}, 02:58:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:58:12 INFO - 'tsvgr_opacity', 02:58:12 INFO - 'tart', 02:58:12 INFO - 'tscrollx', 02:58:12 INFO - 'cart']}, 02:58:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'talos_options': ['--disable-e10s'], 02:58:12 INFO - 'tests': ['tp5o']}, 02:58:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'tests': ['tp5o']}, 02:58:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'talos_options': ['--disable-e10s', 02:58:12 INFO - '--xperf_path', 02:58:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:12 INFO - 'tests': ['tp5n']}, 02:58:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:12 INFO - 'talos_options': ['--xperf_path', 02:58:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:12 INFO - 'tests': ['tp5n']}}, 02:58:12 INFO - 'talos.zip': {'path': '', 02:58:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:58:12 INFO - Running post-action listener: _resource_record_post_action 02:58:12 INFO - ##### 02:58:12 INFO - ##### Finished populate-webroot step (success) 02:58:12 INFO - ##### 02:58:12 INFO - ##### 02:58:12 INFO - ##### Running create-virtualenv step. 02:58:12 INFO - ##### 02:58:12 INFO - Running pre-action listener: _resource_record_pre_action 02:58:12 INFO - Running main action method: create_virtualenv 02:58:12 INFO - Creating virtualenv /builds/slave/test/build/venv 02:58:12 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 02:58:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:58:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:58:12 INFO - Using real prefix '/usr' 02:58:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:58:13 INFO - Installing distribute.............................................................................................................................................................................................done. 02:58:15 INFO - Installing pip.................done. 02:58:15 INFO - Return code: 0 02:58:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:58:15 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')]} 02:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 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')]} 02:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:15 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 02:58:15 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 02:58:15 INFO - Using env: {'DISPLAY': ':0', 02:58:15 INFO - 'HOME': '/home/cltbld', 02:58:15 INFO - 'LANG': 'en_US.UTF-8', 02:58:15 INFO - 'LANGUAGE': 'en_US:en', 02:58:15 INFO - 'LOGNAME': 'cltbld', 02:58:15 INFO - 'MAIL': '/var/mail/cltbld', 02:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:15 INFO - 'MOZ_NO_REMOTE': '1', 02:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:15 INFO - 'NO_EM_RESTART': '1', 02:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:15 INFO - 'PWD': '/builds/slave/test', 02:58:15 INFO - 'SHELL': '/bin/bash', 02:58:15 INFO - 'SHLVL': '1', 02:58:15 INFO - 'TERM': 'linux', 02:58:15 INFO - 'TMOUT': '86400', 02:58:15 INFO - 'USER': 'cltbld', 02:58:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:15 INFO - '_': '/tools/buildbot/bin/python'} 02:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:15 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 02:58:15 INFO - Cleaning up... 02:58:15 INFO - Return code: 0 02:58:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:58:15 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')]} 02:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 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')]} 02:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:15 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 02:58:15 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 02:58:15 INFO - Using env: {'DISPLAY': ':0', 02:58:15 INFO - 'HOME': '/home/cltbld', 02:58:15 INFO - 'LANG': 'en_US.UTF-8', 02:58:15 INFO - 'LANGUAGE': 'en_US:en', 02:58:15 INFO - 'LOGNAME': 'cltbld', 02:58:15 INFO - 'MAIL': '/var/mail/cltbld', 02:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:15 INFO - 'MOZ_NO_REMOTE': '1', 02:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:15 INFO - 'NO_EM_RESTART': '1', 02:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:15 INFO - 'PWD': '/builds/slave/test', 02:58:15 INFO - 'SHELL': '/bin/bash', 02:58:15 INFO - 'SHLVL': '1', 02:58:15 INFO - 'TERM': 'linux', 02:58:15 INFO - 'TMOUT': '86400', 02:58:15 INFO - 'USER': 'cltbld', 02:58:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:15 INFO - '_': '/tools/buildbot/bin/python'} 02:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:15 INFO - Downloading/unpacking psutil>=3.1.1 02:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:58:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:17 INFO - Installing collected packages: psutil 02:58:17 INFO - Running setup.py install for psutil 02:58:17 INFO - building 'psutil._psutil_linux' extension 02:58:17 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 02:58:18 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 02:58:18 INFO - building 'psutil._psutil_posix' extension 02:58:18 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 02:58:18 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 02:58:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:18 INFO - Successfully installed psutil 02:58:18 INFO - Cleaning up... 02:58:18 INFO - Return code: 0 02:58:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:18 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:18 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 02:58:18 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 02:58:18 INFO - Using env: {'DISPLAY': ':0', 02:58:18 INFO - 'HOME': '/home/cltbld', 02:58:18 INFO - 'LANG': 'en_US.UTF-8', 02:58:18 INFO - 'LANGUAGE': 'en_US:en', 02:58:18 INFO - 'LOGNAME': 'cltbld', 02:58:18 INFO - 'MAIL': '/var/mail/cltbld', 02:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:18 INFO - 'MOZ_NO_REMOTE': '1', 02:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:18 INFO - 'NO_EM_RESTART': '1', 02:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:18 INFO - 'PWD': '/builds/slave/test', 02:58:18 INFO - 'SHELL': '/bin/bash', 02:58:18 INFO - 'SHLVL': '1', 02:58:18 INFO - 'TERM': 'linux', 02:58:18 INFO - 'TMOUT': '86400', 02:58:18 INFO - 'USER': 'cltbld', 02:58:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:18 INFO - '_': '/tools/buildbot/bin/python'} 02:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:58:18 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 02:58:18 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 02:58:18 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 02:58:18 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 02:58:18 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 02:58:18 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 02:58:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:58:20 INFO - Installing collected packages: mozsystemmonitor 02:58:20 INFO - Running setup.py install for mozsystemmonitor 02:58:20 INFO - Successfully installed mozsystemmonitor 02:58:20 INFO - Cleaning up... 02:58:20 INFO - Return code: 0 02:58:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:20 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:20 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 02:58:20 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 02:58:20 INFO - Using env: {'DISPLAY': ':0', 02:58:20 INFO - 'HOME': '/home/cltbld', 02:58:20 INFO - 'LANG': 'en_US.UTF-8', 02:58:20 INFO - 'LANGUAGE': 'en_US:en', 02:58:20 INFO - 'LOGNAME': 'cltbld', 02:58:20 INFO - 'MAIL': '/var/mail/cltbld', 02:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:20 INFO - 'MOZ_NO_REMOTE': '1', 02:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:20 INFO - 'NO_EM_RESTART': '1', 02:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:20 INFO - 'PWD': '/builds/slave/test', 02:58:20 INFO - 'SHELL': '/bin/bash', 02:58:20 INFO - 'SHLVL': '1', 02:58:20 INFO - 'TERM': 'linux', 02:58:20 INFO - 'TMOUT': '86400', 02:58:20 INFO - 'USER': 'cltbld', 02:58:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:20 INFO - '_': '/tools/buildbot/bin/python'} 02:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:20 INFO - Downloading/unpacking jsonschema==2.5.1 02:58:20 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 02:58:20 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 02:58:20 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 02:58:20 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 02:58:20 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 02:58:20 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 02:58:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:58:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:58:23 INFO - warning: no files found matching '*.txt' 02:58:23 INFO - no previously-included directories found matching 'build' 02:58:23 INFO - no previously-included directories found matching 'dist' 02:58:23 INFO - no previously-included directories found matching '.git*' 02:58:23 INFO - Installing collected packages: jsonschema, functools32 02:58:23 INFO - Running setup.py install for functools32 02:58:23 INFO - warning: no files found matching '*.txt' 02:58:23 INFO - no previously-included directories found matching 'build' 02:58:23 INFO - no previously-included directories found matching 'dist' 02:58:23 INFO - no previously-included directories found matching '.git*' 02:58:23 INFO - Successfully installed jsonschema functools32 02:58:23 INFO - Cleaning up... 02:58:23 INFO - Return code: 0 02:58:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:23 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')]} 02:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:23 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')]} 02:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:23 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:23 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 02:58:23 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 02:58:23 INFO - Using env: {'DISPLAY': ':0', 02:58:23 INFO - 'HOME': '/home/cltbld', 02:58:23 INFO - 'LANG': 'en_US.UTF-8', 02:58:23 INFO - 'LANGUAGE': 'en_US:en', 02:58:23 INFO - 'LOGNAME': 'cltbld', 02:58:23 INFO - 'MAIL': '/var/mail/cltbld', 02:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:23 INFO - 'MOZ_NO_REMOTE': '1', 02:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:23 INFO - 'NO_EM_RESTART': '1', 02:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:23 INFO - 'PWD': '/builds/slave/test', 02:58:23 INFO - 'SHELL': '/bin/bash', 02:58:23 INFO - 'SHLVL': '1', 02:58:23 INFO - 'TERM': 'linux', 02:58:23 INFO - 'TMOUT': '86400', 02:58:23 INFO - 'USER': 'cltbld', 02:58:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:23 INFO - '_': '/tools/buildbot/bin/python'} 02:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:23 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:23 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 02:58:23 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 02:58:23 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 02:58:23 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 02:58:23 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 02:58:23 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 02:58:25 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:25 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 02:58:25 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 02:58:25 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 02:58:25 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 02:58:25 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 02:58:25 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 02:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:25 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 02:58:25 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 02:58:25 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 02:58:25 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 02:58:25 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 02:58:25 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 02:58:26 INFO - Downloading docopt-0.6.1.tar.gz 02:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:26 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:26 INFO - Running setup.py install for blobuploader 02:58:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:26 INFO - Running setup.py install for requests 02:58:26 INFO - Running setup.py install for docopt 02:58:26 INFO - Successfully installed blobuploader requests docopt 02:58:26 INFO - Cleaning up... 02:58:26 INFO - Return code: 0 02:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:26 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:26 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 02:58:26 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 02:58:26 INFO - Using env: {'DISPLAY': ':0', 02:58:26 INFO - 'HOME': '/home/cltbld', 02:58:26 INFO - 'LANG': 'en_US.UTF-8', 02:58:26 INFO - 'LANGUAGE': 'en_US:en', 02:58:26 INFO - 'LOGNAME': 'cltbld', 02:58:26 INFO - 'MAIL': '/var/mail/cltbld', 02:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:26 INFO - 'MOZ_NO_REMOTE': '1', 02:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:26 INFO - 'NO_EM_RESTART': '1', 02:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:26 INFO - 'PWD': '/builds/slave/test', 02:58:26 INFO - 'SHELL': '/bin/bash', 02:58:26 INFO - 'SHLVL': '1', 02:58:26 INFO - 'TERM': 'linux', 02:58:26 INFO - 'TMOUT': '86400', 02:58:26 INFO - 'USER': 'cltbld', 02:58:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:26 INFO - '_': '/tools/buildbot/bin/python'} 02:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:26 INFO - Running setup.py (path:/tmp/pip-5ecbMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:26 INFO - Running setup.py (path:/tmp/pip-AjL_ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:27 INFO - Running setup.py (path:/tmp/pip-okcxxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:27 INFO - Running setup.py (path:/tmp/pip-tua_Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:27 INFO - Running setup.py (path:/tmp/pip-7Ae0I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:27 INFO - Running setup.py (path:/tmp/pip-ZLyfZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:27 INFO - Running setup.py (path:/tmp/pip-qcOsTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:27 INFO - Running setup.py (path:/tmp/pip-fs4TLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:27 INFO - Running setup.py (path:/tmp/pip-jXuZdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:27 INFO - Running setup.py (path:/tmp/pip-f7iMnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:27 INFO - Running setup.py (path:/tmp/pip-Q1B2lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:27 INFO - Running setup.py (path:/tmp/pip-CBoi1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:27 INFO - Running setup.py (path:/tmp/pip-9xuUcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:27 INFO - Running setup.py (path:/tmp/pip-QBz5bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:27 INFO - Running setup.py (path:/tmp/pip-fda3g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:27 INFO - Running setup.py (path:/tmp/pip-y_mz79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:28 INFO - Running setup.py (path:/tmp/pip-2qiBzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:28 INFO - Running setup.py install for manifestparser 02:58:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozcrash 02:58:28 INFO - Running setup.py install for mozdebug 02:58:28 INFO - Running setup.py install for mozdevice 02:58:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozfile 02:58:28 INFO - Running setup.py install for mozhttpd 02:58:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozinfo 02:58:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozInstall 02:58:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozleak 02:58:29 INFO - Running setup.py install for mozlog 02:58:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Running setup.py install for moznetwork 02:58:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Running setup.py install for mozprocess 02:58:29 INFO - Running setup.py install for mozprofile 02:58:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Running setup.py install for mozrunner 02:58:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Running setup.py install for mozscreenshot 02:58:29 INFO - Running setup.py install for moztest 02:58:29 INFO - Running setup.py install for mozversion 02:58:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:29 INFO - Cleaning up... 02:58:29 INFO - Return code: 0 02:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:29 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')]} 02:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:29 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')]} 02:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:29 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:29 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 02:58:29 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 02:58:29 INFO - Using env: {'DISPLAY': ':0', 02:58:29 INFO - 'HOME': '/home/cltbld', 02:58:29 INFO - 'LANG': 'en_US.UTF-8', 02:58:29 INFO - 'LANGUAGE': 'en_US:en', 02:58:29 INFO - 'LOGNAME': 'cltbld', 02:58:29 INFO - 'MAIL': '/var/mail/cltbld', 02:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:29 INFO - 'MOZ_NO_REMOTE': '1', 02:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:29 INFO - 'NO_EM_RESTART': '1', 02:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:29 INFO - 'PWD': '/builds/slave/test', 02:58:29 INFO - 'SHELL': '/bin/bash', 02:58:29 INFO - 'SHLVL': '1', 02:58:29 INFO - 'TERM': 'linux', 02:58:29 INFO - 'TMOUT': '86400', 02:58:29 INFO - 'USER': 'cltbld', 02:58:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:29 INFO - '_': '/tools/buildbot/bin/python'} 02:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:30 INFO - Running setup.py (path:/tmp/pip-SH3lnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:30 INFO - Running setup.py (path:/tmp/pip-qBN_Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:30 INFO - Running setup.py (path:/tmp/pip-9jufTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:30 INFO - Running setup.py (path:/tmp/pip-M5o4Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:30 INFO - Running setup.py (path:/tmp/pip-Gv41vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:30 INFO - Running setup.py (path:/tmp/pip-iv46ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:30 INFO - Running setup.py (path:/tmp/pip-jxqcRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:30 INFO - Running setup.py (path:/tmp/pip-GJPR1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:30 INFO - Running setup.py (path:/tmp/pip-XmUBYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:30 INFO - Running setup.py (path:/tmp/pip-Ar3vHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:30 INFO - Running setup.py (path:/tmp/pip-PmQwy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:30 INFO - Running setup.py (path:/tmp/pip-UzA_Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:31 INFO - Running setup.py (path:/tmp/pip-GHqiPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:31 INFO - Running setup.py (path:/tmp/pip-28mTXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:31 INFO - Running setup.py (path:/tmp/pip-GbWOtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:31 INFO - Running setup.py (path:/tmp/pip-Iuddtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:31 INFO - Running setup.py (path:/tmp/pip-PpPK0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:33 INFO - Downloading blessings-1.6.tar.gz 02:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:33 INFO - Installing collected packages: blessings 02:58:33 INFO - Running setup.py install for blessings 02:58:33 INFO - Successfully installed blessings 02:58:33 INFO - Cleaning up... 02:58:33 INFO - Return code: 0 02:58:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:33 INFO - Reading from file tmpfile_stdout 02:58:33 INFO - Current package versions: 02:58:33 INFO - argparse == 1.2.1 02:58:33 INFO - blessings == 1.6 02:58:33 INFO - blobuploader == 1.2.4 02:58:33 INFO - docopt == 0.6.1 02:58:33 INFO - functools32 == 3.2.3-2 02:58:33 INFO - jsonschema == 2.5.1 02:58:33 INFO - manifestparser == 1.1 02:58:33 INFO - mozInstall == 1.12 02:58:33 INFO - mozcrash == 0.17 02:58:33 INFO - mozdebug == 0.1 02:58:33 INFO - mozdevice == 0.48 02:58:33 INFO - mozfile == 1.2 02:58:33 INFO - mozhttpd == 0.7 02:58:33 INFO - mozinfo == 0.9 02:58:33 INFO - mozleak == 0.1 02:58:33 INFO - mozlog == 3.2 02:58:33 INFO - moznetwork == 0.27 02:58:33 INFO - mozprocess == 0.22 02:58:33 INFO - mozprofile == 0.28 02:58:33 INFO - mozrunner == 6.11 02:58:33 INFO - mozscreenshot == 0.1 02:58:33 INFO - mozsystemmonitor == 0.3 02:58:33 INFO - moztest == 0.7 02:58:33 INFO - mozversion == 1.4 02:58:33 INFO - psutil == 3.1.1 02:58:33 INFO - requests == 1.2.3 02:58:33 INFO - wsgiref == 0.1.2 02:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:33 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:33 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 02:58:33 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 02:58:33 INFO - Using env: {'DISPLAY': ':0', 02:58:33 INFO - 'HOME': '/home/cltbld', 02:58:33 INFO - 'LANG': 'en_US.UTF-8', 02:58:33 INFO - 'LANGUAGE': 'en_US:en', 02:58:33 INFO - 'LOGNAME': 'cltbld', 02:58:33 INFO - 'MAIL': '/var/mail/cltbld', 02:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:33 INFO - 'MOZ_NO_REMOTE': '1', 02:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:33 INFO - 'NO_EM_RESTART': '1', 02:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:33 INFO - 'PWD': '/builds/slave/test', 02:58:33 INFO - 'SHELL': '/bin/bash', 02:58:33 INFO - 'SHLVL': '1', 02:58:33 INFO - 'TERM': 'linux', 02:58:33 INFO - 'TMOUT': '86400', 02:58:33 INFO - 'USER': 'cltbld', 02:58:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:33 INFO - '_': '/tools/buildbot/bin/python'} 02:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 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)) 02:58:33 INFO - Cleaning up... 02:58:33 INFO - Return code: 0 02:58:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58: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', 'jsonschema'] in /builds/slave/test/build 02:58: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 jsonschema 02:58:33 INFO - Using env: {'DISPLAY': ':0', 02:58:33 INFO - 'HOME': '/home/cltbld', 02:58:33 INFO - 'LANG': 'en_US.UTF-8', 02:58:33 INFO - 'LANGUAGE': 'en_US:en', 02:58:33 INFO - 'LOGNAME': 'cltbld', 02:58:33 INFO - 'MAIL': '/var/mail/cltbld', 02:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:33 INFO - 'MOZ_NO_REMOTE': '1', 02:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:33 INFO - 'NO_EM_RESTART': '1', 02:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:33 INFO - 'PWD': '/builds/slave/test', 02:58:33 INFO - 'SHELL': '/bin/bash', 02:58:33 INFO - 'SHLVL': '1', 02:58:33 INFO - 'TERM': 'linux', 02:58:33 INFO - 'TMOUT': '86400', 02:58:33 INFO - 'USER': 'cltbld', 02:58:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:33 INFO - '_': '/tools/buildbot/bin/python'} 02:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:34 INFO - Cleaning up... 02:58:34 INFO - Return code: 0 02:58:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:58:34 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')]} 02:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:34 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')]} 02:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:34 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 0x7f62a83c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, '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': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', '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 02:58:34 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 02:58:34 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 02:58:34 INFO - Using env: {'DISPLAY': ':0', 02:58:34 INFO - 'HOME': '/home/cltbld', 02:58:34 INFO - 'LANG': 'en_US.UTF-8', 02:58:34 INFO - 'LANGUAGE': 'en_US:en', 02:58:34 INFO - 'LOGNAME': 'cltbld', 02:58:34 INFO - 'MAIL': '/var/mail/cltbld', 02:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:34 INFO - 'MOZ_NO_REMOTE': '1', 02:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:34 INFO - 'NO_EM_RESTART': '1', 02:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:34 INFO - 'PWD': '/builds/slave/test', 02:58:34 INFO - 'SHELL': '/bin/bash', 02:58:34 INFO - 'SHLVL': '1', 02:58:34 INFO - 'TERM': 'linux', 02:58:34 INFO - 'TMOUT': '86400', 02:58:34 INFO - 'USER': 'cltbld', 02:58:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:34 INFO - '_': '/tools/buildbot/bin/python'} 02:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:34 INFO - Downloading/unpacking flake8 02:58:34 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 02:58:34 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 02:58:34 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 02:58:34 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 02:58:34 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 02:58:34 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 02:58:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:58:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:58:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58: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 02:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:58:37 INFO - no previously-included directories found matching 'docs/_build' 02:58:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:58:37 INFO - Running setup.py install for pep8 02:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:58:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:58:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:58:37 INFO - no previously-included directories found matching 'docs/_build' 02:58:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:58:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:58:37 INFO - Cleaning up... 02:58:37 INFO - Return code: 0 02:58:37 INFO - Running post-action listener: _resource_record_post_action 02:58:37 INFO - Running post-action listener: _start_resource_monitoring 02:58:37 INFO - Starting resource monitoring. 02:58:37 INFO - ##### 02:58:37 INFO - ##### Finished create-virtualenv step (success) 02:58:37 INFO - ##### 02:58:37 INFO - ##### 02:58:37 INFO - ##### Running install step. 02:58:37 INFO - ##### 02:58:37 INFO - Running pre-action listener: _resource_record_pre_action 02:58:37 INFO - Running main action method: install 02:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:37 INFO - Reading from file tmpfile_stdout 02:58:37 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:37 INFO - Reading from file tmpfile_stdout 02:58:37 INFO - Output received: 02:58:37 INFO - Usage: mozinstall [options] installer 02:58:37 INFO - Options: 02:58:37 INFO - -h, --help show this help message and exit 02:58:37 INFO - -d DEST, --destination=DEST 02:58:37 INFO - Directory to install application into. [default: 02:58:37 INFO - "/builds/slave/test"] 02:58:37 INFO - --app=APP Application being installed. [default: firefox] 02:58:37 INFO - mkdir: /builds/slave/test/build/application 02:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:58:53 INFO - Reading from file tmpfile_stdout 02:58:53 INFO - Output received: 02:58:53 INFO - /builds/slave/test/build/application/firefox/firefox 02:58:53 INFO - Running post-action listener: _resource_record_post_action 02:58:53 INFO - ##### 02:58:53 INFO - ##### Finished install step (success) 02:58:53 INFO - ##### 02:58:53 INFO - ##### 02:58:53 INFO - ##### Running run-tests step. 02:58:53 INFO - ##### 02:58:53 INFO - Running pre-action listener: _resource_record_pre_action 02:58:53 INFO - Running main action method: run_tests 02:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:53 INFO - Python 2.7.3 02:58:53 INFO - Return code: 0 02:58:53 INFO - grabbing minidump binary from tooltool 02:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:58:53 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 0x2be4710>, '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 0x2be5610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:53 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 02:58:53 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 02:58:53 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 02:58:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:53 INFO - Return code: 0 02:58:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:58:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:58:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:58:54 INFO - Return code: 0 02:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 02:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 02:58:54 INFO - Using env: {'DISPLAY': ':0', 02:58:54 INFO - 'HOME': '/home/cltbld', 02:58:54 INFO - 'LANG': 'en_US.UTF-8', 02:58:54 INFO - 'LANGUAGE': 'en_US:en', 02:58:54 INFO - 'LOGNAME': 'cltbld', 02:58:54 INFO - 'MAIL': '/var/mail/cltbld', 02:58:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:54 INFO - 'MOZ_NO_REMOTE': '1', 02:58:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:54 INFO - 'NO_EM_RESTART': '1', 02:58:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:54 INFO - 'PWD': '/builds/slave/test', 02:58:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:54 INFO - 'SHELL': '/bin/bash', 02:58:54 INFO - 'SHLVL': '1', 02:58:54 INFO - 'TERM': 'linux', 02:58:54 INFO - 'TMOUT': '86400', 02:58:54 INFO - 'USER': 'cltbld', 02:58:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694', 02:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:54 INFO - '_': '/tools/buildbot/bin/python'} 02:58:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 02:58:55 INFO - mozversion application_buildid: 20160628022621 02:58:55 INFO - mozversion application_changeset: 4db7a29c60ddf136d49d24d901c93b4acdfe664a 02:58:55 INFO - mozversion application_display_name: Nightly 02:58:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:55 INFO - mozversion application_name: Firefox 02:58:55 INFO - mozversion application_remotingname: firefox 02:58:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:58:55 INFO - mozversion application_vendor: Mozilla 02:58:55 INFO - mozversion application_version: 50.0a1 02:58:55 INFO - mozversion platform_buildid: 20160628022621 02:58:55 INFO - mozversion platform_changeset: 4db7a29c60ddf136d49d24d901c93b4acdfe664a 02:58:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:58:55 INFO - mozversion platform_version: 50.0a1 02:58:55 INFO - using testdate: 1467107935 02:58:55 INFO - actual date: 1467107935 02:58:55 INFO - starting webserver on 'localhost:40143' 02:58:55 INFO - SUITE-START | Running 2 tests 02:58:55 INFO - TEST-START | dromaeo_css 02:58:55 INFO - operating with platform_type : linux_ 02:58:55 INFO - Initialising browser for dromaeo_css test... 02:58:55 INFO - TEST-INFO | started process 28932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_IL6vE/profile http://localhost:40143/getInfo.html) 02:59:00 INFO - PROCESS | 28932 | __metrics Screen width/height:1600/1200 02:59:00 INFO - PROCESS | 28932 | colorDepth:24 02:59:00 INFO - PROCESS | 28932 | Browser inner width/height: 1024/697 02:59:00 INFO - PROCESS | 28932 | __metrics 02:59:01 ERROR - PROCESS | 28932 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:59:02 INFO - TEST-INFO | 28932: exit 0 02:59:02 INFO - Browser initialized. 02:59:02 INFO - Running cycle 1/1 for dromaeo_css test... 02:59:02 INFO - TEST-INFO | started process 29051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_IL6vE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:14 INFO - PROCESS | 29051 | RSS: Main: 186433536 02:59:14 INFO - PROCESS | 29051 | 03:00:04 INFO - PROCESS | 29051 | 1467108004072 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] 03:02:16 INFO - PROCESS | 29051 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40143/tests/dromaeo/cssquery-ext.html) 03:02:17 INFO - PROCESS | 29051 | RSS: Main: 189206528 03:02:17 INFO - PROCESS | 29051 | 03:05:19 INFO - PROCESS | 29051 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-ext.html (next: http://localhost:40143/tests/dromaeo/cssquery-jquery.html) 03:05:20 INFO - PROCESS | 29051 | RSS: Main: 188301312 03:05:20 INFO - PROCESS | 29051 | 03:08:22 INFO - PROCESS | 29051 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40143/tests/dromaeo/cssquery-mootools.html) 03:08:22 INFO - PROCESS | 29051 | RSS: Main: 189476864 03:08:22 INFO - PROCESS | 29051 | 03:11:24 INFO - PROCESS | 29051 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40143/tests/dromaeo/cssquery-prototype.html) 03:11:25 INFO - PROCESS | 29051 | RSS: Main: 186626048 03:11:25 INFO - PROCESS | 29051 | 03:14:28 INFO - PROCESS | 29051 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40143/tests/dromaeo/cssquery-yui.html) 03:14:28 INFO - PROCESS | 29051 | RSS: Main: 189100032 03:14:28 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-yui.html (next: http://localhost:40143/tests/dromaeo/cssquery-dojo.html) 03:17:31 INFO - PROCESS | 29051 | RSS: Main: 190099456 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | __start_tp_report 03:17:31 INFO - PROCESS | 29051 | _x_x_mozilla_page_load 03:17:31 INFO - PROCESS | 29051 | _x_x_mozilla_page_load_details 03:17:31 INFO - PROCESS | 29051 | |i|pagename|runs| 03:17:31 INFO - PROCESS | 29051 | |0;dojo.html;2635.499255141523;2690.0988168963395;2707.4314393977265;2725.4004119093793;2727.6317697110885;4903.068417000767;4917.262410638402;4963.329950456697;4970.229614409768;5035.496450354972;4902.240152776317;4983.975080124595;4989.850304490862;4991.326170966928;5030.798768049273;4489.595936365735;4535.7958891849785;4656.185167595674;4663.976680116594;4674.626029917616;557.8694487068793;4430.867073987785;4477.731336119827;4518.254488009491;4576.153411618861;4548.204064288753;4578.519255478193;4581.381513495702;4585.977070114662;4600.608948239404;4593.977030114861;4601.7699115044115;4603.309503574457;4613.123506533748;4657.650676199265;4448.755318457484;4513.435820522434;4521.276595744698;4524.954750452486;4528.18492671319;4868.902621947541;4926.088673595396;4994.800207991676;5001.874953126165;5081.339425874649;5304;5364.034473794715;5381.784728610851;5383.946160538384;5384.6499977501335;5378.300820893259;5448.727563621843;5459.808906688287;5461.15352120422;5530.170474428827;5011.749412529359;5013.974930125362;5018.422881368653;5041.344625198774;5089.643724939218;5306.469353064663;5421.078416669096;5484.287042684426;5501.4223506532035;5512.3660779010925;5252.264682944391;5269.604779641542;5269.868253293698;5295.735213239323;5314.468553144655;5419.295491586147;5423.18652202165;5425.972870135703;5434.592405569519;5486.972565137149;5068.721220332917;5215.400228973641;5232.947670523322;5268.525832675077;5349.625526213128;5245.7114858683135;5263.3947096083675;5275.103232450492;5281.762320695578;5290.894182116336;4559.658025648089;4568.040711450632;4572.611328037087;4589.747563884019;4602.861914142581;3840.9807950960626;3915.7063220258597;3921.0589458530317;3936.842526298916;3956.8615098471414;4615.584597386184;4642.791074401593;4649.442066951988;4652.092841895866;4696.037312351028;5432.402435732066;5433.864153396117;5435.619506634498;5459.645123067067;5478.506934375925;4533.32000199966;4571.542845715402;4584.977075114603;4586.197415452282;4603.125406172817;4765;4786.114568804782;4789.976050119727;4823.252395878644;4840.249761287007;4934.087193869145;4965.776540055634;4971.9005619886675;4986.950130498649;5013.273075404119;5252.816151434834;5259.8422047338645;5309.36287645485;5316.388615309289;5328.813491527778;4978.2781496682055;4979.925301120414;4981.701097934136;4984.352034235526;5039.924401134059;5137.023965446553;5244.973775131252;5257.053730328577;5260.184671375943;5261.631685781958;5260.44765299638;5274.657147285414;5323.520883120537;5343.866403339947;5352.41123476425;5132.538071573576;5135.589152867687;5137;5155.819546315861;5156.922646160386;5045.344105266292;5131.025105229995;5144.9742751286;5157.174852023658;5163.380394352552;5128.666636668605;5164.715940623302;5175.896482070262;5194.428612852659;5216.087184742731;5290.65610735301;5298.28473156119;5310.336207974004;5311.49540793624;5365;4988.152014157529;5110.9488905110475;5139.100657384868;5189.247559103834;5192.714400707997 03:17:31 INFO - PROCESS | 29051 | |1;ext.html;534.472563588942;572.9972548040928;583.6527266276564;589.9174115623811;613.9171211886394;36274.27451450973;37667.81166094169;40674.796626016905;40707.18585628286;40734.59265407345;40875.386869196984;40963.79518102413;41349.79325103378;41372.17255654885;41479.79260103703;8025.478343907642;8079.394045446586;8091.959540202291;8094.069182044082;8129.512229266234;7853.2539408756365;7951.40364472664;8047.195280471935;8069.515829050276;8075.555844428554;8030.156833532483;8050.275475207231;8077.555734434603;8106.675732970674;8107.716229931953;7935.722249721261;7980.042394912648;7995.840083198304;8007.039155301343;8028;7963.124056353797;7995.040595128564;8070.9192908071345;8093.312068474187;8097.473664211808;29956.400871982656;32450.350992980246;32610.673893261002;32817.67182328194;32876.6712332876;2968.83671398073;2981.940361192764;3073.3853229354218;3080.1221651829346;3577.606463289036;28216.576751348744;28896.422071558452;29185.708142918724;32161.356772864412;32926.83536582326;3482.21650128719;3554.59122200945;3592.604813470516;3601.8559257629663;3602.9279414411826;270628;271580;273924;274106;274708.999999998;57506;58133;58253;58588;58607.706961465774;33661.66338336634;34515.13712157166;34817.30365392678;60177.38935663874;60245.698771505864;13116.606501804961;13122.540711075066;13197.868021319857;13204.867951320555;13266.800997985038;10235;10285.485725713685;10372.11836993849;10394.740131496774;10400.115990140772;18366.724499132524;18454.26182952694;18483.87435444941;18617.720734189;18773;7090.184628767758;7164.21193668696;7305.159906610702;7312.707491700379;7377.483576149618;803.3894240377356;811.8173410982599;932.4591736792644;935.6713516523334;1048.2295512798087;26878.731212687624;27014.1895743128;27489;27520.17439476819;27844.860775695994;961.1445813226235;970.752458123174;992.7766252593109;993.6869885985891;1078.8489611454402;14693.338799754038;14772.778408323884;14932.776008359884;15091.320890559951;15204.46784362542;396057;396261;396831;400151;402090;51177;51381;51536.742316288175;51553;51857.48142518602;1179.2217136689915;1215.3376409856648;1217.1540779158577;1217.8843009914044;1225.5649244518247;26489.33776655599;27058.864705676344;27497.587536186573;27548.862255688593;27775.30561735973;43376.78311608422;43417;44234;44270;44281.778591106835;364070;365785;367691;367766;367769;25900.22299331023;25973;26128;26396;26443;40117.398239027025;42316.78841605772;43573.34639980339;43739.34390984074;43843.78078109589;35896.46155307725;36331;36522.8173859129;36642.81678591697;37004.62995370012;36453;36583.26833463262;36948.630513694516;36983.44524832076;37022.70420535268;35428.64571354254;35910;36037.639623604475;36729.63270367262;36801.447978279815;32287.51568726424;32656.51015234726;32703.34593308168;32898.34203315968;33100.66899330976;25380.492390152463;25569.23292301234;25653.358666032753;25709.871450642626;26091.739082608932 03:17:31 INFO - PROCESS | 29051 | |2;jquery.html;373.72531189575676;374.6122762940357;376.91142581493347;385.9421086836976;387.7402140565821;15554.688906221869;16855.325786968522;17050.232739526706;17387.39144129956;17395.82604173958;15401.3839446422;16231.513054608351;16511.587210319747;16540.09029503377;16583.253753581088;5100.540951314381;5269.130593452095;5306.522412982831;5315.01672190646;5319.308489896327;3673.797941113238;5092.414372347172;5748.971255143719;6039.637621742688;6042.939570604303;6118.11287363332;6125.234345706786;6131.3562075982045;6142.324344322144;6158.476529494998;5016.222485514732;5331.520163185312;5346.331708536433;5367.43641917597;5392.676439413648;5199.558037566811;5203.089459344637;5259.395169555473;5265.631405801595;5288.444713305086;18138;19295.4211373659;19329.130189141382;19914.900425497926;20249.39251822448;1892.3660573707825;1955.3351860367402;1964.3223088034606;2087.5407410369694;2327.487952650414;9134.81730365389;9160.35877488576;9312.161905428544;9373.812523749486;9532.714018579454;1774.1395423219728;1784.1079460269866;1795.4703362508092;1806.7018941874576;1818.4453741608804;46388;68208.97686534756;68924.65537672279;69261.30738692598;70103.64948175277;9817.312788104908;10033.849492257623;10088.899111008943;10171.54228059739;10331.535080921376;13700;13756.724865502634;13871.167729936236;13887.652808679662;13937;7066.964665176642;7191.424686025105;7253.818654533573;7282.235365286569;7344.889826652605;6768.08630834831;6787.592744435349;6814.693338799766;6855.6572171391235;6863.073485079551;4243.321068629005;4305.117450922553;4318.481782186095;4335.612603966701;4483.237849565582;1598.6802639472153;1641.9096949667883;1835.7797064352362;1840.1811194018533;1894.4411398637435;790.6521130702472;820.8522465956186;893.2898345815092;909.077286554148;961.2550273538064;16121.032738035756;16393.754093688603;16760.413385531447;16767.161641917854;16982.57543561421;861.6338056326036;872.0988047174917;888.8000199954959;898.883145191121;921.4149015375151;8954.552272386354;9459.810803783887;9468;9475.052494750607;9534.761630959281;374595.12702436314;377867;384487;388619;389344;67787.3221267781;73082.63458682672;75275.24724752683;75443.24556754362;76576.23423765802;899.6131663384676;899.7705585075764;903.3721563513295;916.6562539047857;924.8104138651426;15010.174440405883;15394.230288485754;15429.305681244146;15676;15687;34056.48915266224;35350.64649353473;35482;36970.260594788495;37716.81141594274;47362.52637473581;50677.49322506728;50777.74611126921;51015.489845101074;51117.48882511276;7863.764087077397;7882.132965373919;7888.723894663659;7970.561619111005;8102.270795628422;11753.882461175279;11813.704657383634;12171.391430428266;12231.388430578258;12298.139130260795;9460.526973651153;9661.13049825519;10024.14794742455;10206.336588121749;10533.104686101768;6204.5967012144065;9343.71968840936;10776.67669969902;10799.67600971972;10809;10114.494275286059;10133.543990520297;10337.74155646115;10458.163346932075;10697.786044279226;7942.364610831004;7989.041315042232;8021.679132834622;8055.315298199719;8075.353971682134;10151.64469243573;10196.13332866685;10212.948935255276;10238.641647542301;10672.83990740155 03:17:31 INFO - PROCESS | 29051 | |3;mootools.html;1360.1838896662005;1417.4755340524005;1474.2407660055067;1666.7749853769737;1677.3793696332352;7057.894131588017;7803.687852485901;7914.445988780788;8342.290905273052;8370.372222083346;8001.519908805476;8260.091389947102;8327.750167494969;8331.958340208306;8337.749867503984;2224.7663995280504;2261.027758064032;2261.547690461914;2263.581237471065;2266.9773302267013;2148.0655914677086;2149.5271040371094;2156.223759446598;2164.5562659654734;2206.569718904814;2180.509385388291;2190.69330293759;2198.329509499602;2202.768709285526;2203.9559208815813;2079.4697352175176;2180.8582442141287;2202.130158587349;2205.977940220593;2227.220472834495;2167.6098302305577;2203.9559208815895;2206.1837120265604;2210.160139147114;2215.9335219943428;8261.917380826235;8265.504069755834;8302.418830681854;8339.416240863142;8384.916150838475;4723.504032076651;4899.216125419915;4903.730294833783;4903.926441103386;4954.182559877616;2909.839958802265;3002.0993701889565;3004.534297183918;3014.0807053848566;3045.923851903698;970.3013830042429;1004.6634377483551;1016.6340117557673;1776.733489976501;1813.102514255452;11068;11192.496337664825;11246.044086252678;11263.774724505463;11285.661430157108;4112.485939257593;4197.349410841263;4284.464441944757;4295.699301048897;4302.634276086567;8912.598933048028;8913.643454261757;8930.419522731132;8940.910590894007;8949.060348663426;4743.976280118577;4754.4532378776885;4756.9286460703115;4757.215059515211;4763.356946812136;3902;4243.745375277494;4365.039691267916;4432.3794668746405;4442.4669039715445;3796.487474190949;3837.2901013312626;3894.3963685628773;3935.878274691699;3984.581618929971;1236.5424792826711;1263.1789336931067;1268.6447794617523;1272.2557303977278;1275.5025540039392;801.1988011988012;811.2414892075927;815.6859609050558;827.8302947895667;846.3736834742247;5292.391374991848;5489.1217405214975;5558.555315574825;5648.322201335866;5735.082386818172;831.7920519870032;842.7092653034694;876.8640860666607;892.4779004282567;916.8074704312036;3292.3415316936707;3551.751377403609;3836.1943991761486;3936.803159842054;3937.3503371943307;9825.852612210823;10235.43705096212;10298.279120461495;10301.330413523097;10324.22568307365;9567.760805979768;10044.397336159855;10067.244956628283;10159.187265018929;10165.4917254137;7381.11426628808;7518.323350898336;7748.147703752583;7788.065432148179;7807.531548107132;5659.773609055592;5734.885302294014;5750.281214848144;5761.683107429131;5943.049112142036;9294;9297.395669281475;9411.388259763093;9503.287253455881;9575.23398128134;9203.263738900738;9438.811223775348;9675.129238368581;9714.75713107178;9776.657816976656;6484.675766211765;6935.826604334932;6942.444604431735;7085.751998680022;7180.1742799578715;7760.379169666526;7789.221077892392;7853.921460785547;7932.0878099017045;7943.682252709827;6584.4732421405215;6755.898661519983;6851.725930962905;6875.7937261882225;6991.510594258353;7034.753783617549;7057.258987806206;7073.469489788184;7162.820929476805;7183.640817958976;6159.168512250789;6368.840778980562;6390.169277993831;6410.262819775786;6427.678616069272;4457.5096739358;4495.43807024122;4517;4518.231900576844;4619.769011549476;4498.77506124699;4509.804901700986;4613.538646135359;4643.071385722801;4661.440627124767 03:17:31 INFO - PROCESS | 29051 | |4;prototype.html;304.92834183966767;313.0701815607645;316.78775220602193;318.8182735840571;321.1009174311926;4927.339236812117;5019.623528235379;5083.872903177423;5165.431802501722;5190.403103643087;5050.217216331465;5118.718470484131;5139.563137133338;5155.329807125077;5161.509656582628;4002.659109198422;4023.295923213426;4030.6170913763144;4030.690025741631;4048.170125124357;3938.8818335449837;4034.2334956358345;4036.8788936331957;4050.7569545827196;4074.2869997750277;3976.3439032559595;3994.241094192109;3996.3006473867104;4005.8998525036964;4008.498937632796;3993.7803420811842;4026.3759117336713;4046.2514434829354;4047.1872048926007;4052.7365721228025;3561.1809283864595;3591.066322756102;3592.1019745063736;3602.3875941090078;3618.2763447310645;4779.593734532569;4957.429895562021;4968.850934471971;4993.725345106018;5088.821891233826;4553.203189441868;4574.771261436948;4588.7476188809605;4596.35651008859;4597.724136551784;5362;5371.435999220064;5376.91934620981;5379.193121031837;5408.755986123214;3517.771344862576;3745.325841348556;3771.4719939208258;3790.4503846942316;3901.317269477858;5593.832185034415;5623.425440876561;5623.831285061455;5636.718164091779;5672.432756724335;3829.3490106681375;3839.6736277416176;3853.8843834685003;3865.4781604483037;3869.2648396804516;3859.903502412406;3870.8645197417954;3931.233409485123;3931.4863777445316;3949.229900169497;4432.534583868647;4461.687681862303;4470.865874023784;4474.373587697725;4480.708753930984;5330.280412144389;5347.278117454094;5350.491703288181;5356.276902618175;5379.220013098079;1287.8905293050195;1334.726381091874;1367.4325155060737;1369.657585603599;1373.684052667872;857.8198578298502;864.6368525219423;874.6020560644891;880.295763389286;884.9469031858109;4219.683523735732;4219.746815191098;4252;4283.914321713548;4292.828286868553;4833.347498087714;4850.490698476609;4890.682105663121;4973.651844370932;4986.551210391082;4256.255155347863;4259.552746961586;4262.936055959163;4267.914641707211;4334.696571240046;2512.078260131001;2602.895884164612;2633.8814753336146;2657.0700254910626;2665.8267212631117;4591.334256532784;4648.721076735406;4671.48613652498;4686.929696054562;4716.316134160527;4907.852764417074;5057.836697559582;5071.949280507221;5080.034793389244;5088.542031217208;4505.639548836085;4531.954680453219;4606.618014595675;4651.046535460155;4667.463241727177;4866.586340161126;4885.560299573055;4916.385451818523;4921.212605983025;4969.279454479008;4802.111609352281;4813.374261346143;4842.789302674331;4883.3651625288485;4883.389576302962;4810.735409552368;5264.236685680631;5286.524212820865;5288.735563221747;5296.841094767163;3864.246471937945;3929.426225822091;3945.4279129525485;3952.782596957195;3973.165635216637;5090.516400941905;5635.605507614428;5640.097584386478;5644.491995720241;5651;5300.867478312919;5333.093374126331;5342.519173274424;5348.5186333230195;5373.11343628297;5277;5296.41739408657;5299.39057008449;5312.495312945264;5353.189575472908;5094.681919726441;5223.399309079505;5252.2646829444675;5279.39286982002;5307.867303317448;5346.919796202982;5375.919361209663;5391.32608423947;5402.216678581663;5406.486383793534;5266.947330526799;5289.7619607117;5325.201219817059;5349.919751203657;5356.3572371315695 03:17:31 INFO - PROCESS | 29051 | |5;yui.html;700.9485771342986;710.7512370670266;724.7572063358774;749.411711806232;755.3126654744177;11689.883101168996;11874.940625296873;12050.758984820299;12715.42780574874;12763.553275635355;13103.410346534405;13190.472381104768;13317.600471985856;13344.2660653664;13358.93320533396;625.8060001399558;766.632016632017;781.8709912864384;797.1191833024511;797.6450479536609;785.968561257549;795.1253621016864;795.157133438557;798.3094623150962;802.7511471443842;845.480029781686;846.9830603387928;848.0840692052599;849.8385306791721;849.9065102838683;833.5373867503503;841.3017195727532;842.6882053640162;842.7556008757452;844.9957750211271;610.8442347201435;611.013213659936;614.1586027142843;614.2659521871366;614.6158650843223;12025.699357516132;12150.939245303805;12201.816972745415;12251.93874030633;12259.816102758467;13851.16892986424;14064;14081.295935203301;14203.076800007966;14494.05788623736;10409.479526023744;10428.217883658755;10569.41868197249;10756.462176891124;10795.730106747316;4349.304111342201;4372.103718737651;4372.781360931941;4375.737455752633;4458.7324760514475;58952.70523647354;59369.7031514844;59512.70243648754;59689;59907;10385.480725963671;10467.738306542245;10548.208884333551;10641.095506881848;10729.785404292026;17272.481825545256;17948.37180698669;17955.640887182184;17969.460916172273;17995.280188792563;6980.581165130007;7189.424846012306;7265.382442492341;7282.854342913112;7344.118705755237;3778.8110594470168;3806.9619303807162;3824.388097904322;3863.594322596087;3893.980530097331;3055.4805683033937;3127.4839651457255;3164.857581408842;3169.0492852144266;3185.9362812743616;538.5072658517491;543.9646422982494;546.7976848566057;553.1343447504643;562.8649124210242;552.4558310064583;575.0167214063914;575.5827025406546;593.7476572456688;605.4429924469499;7076.787696369117;7203.423726101899;7272.96363518179;7329.706811727471;7532.209118042636;557.6626141184606;564.1903867949505;578.887117012187;578.8986927287708;584.7719389438123;3455.1534873956043;3530.223350862806;3576.8926932192076;3588.784672919633;3596.3886139356373;86849;88810;89464.55267723619;92374;94779;62311;76798.6160069196;77279;77525.61237193778;78959.60520197477;69121;69505.65247173731;70304.29695702977;70573.64713176401;71296.28703713001;6670.39966403026;6744.359285867835;6782.220044694924;6821.2155602106395;6904;40779.38830917598;41382.586174137876;42223;42529.36205956975;43217.135657287305;53174.20238696345;60452.6977365128;60757;61398.386016141056;61988.69005655123;8844.115588441104;9130.543472826464;9311.627534898527;9368.203702685349;9579.329446938647;9641.469719165514;9820.263480239153;11932.22440541362;12304.200226985216;12486.125971182293;10457.16342692598;10522.158227341948;10808.513616887416;11099.334039957628;11533.250338728292;11747.765044699228;11777.882221177679;11778.352190629597;11844.1709080367;11964.490549099588;10710.785784284426;10776.946115269373;10845.403502807421;11035.724106897393;11196.38419886914;9315.115064068903;9359;9401.294902882175;9523.095305945924;9748.561314740995;9099.272058235458;9188.540572971458;9371.250299976122;9622.807543849223;9661.758456038655 03:17:31 INFO - PROCESS | 29051 | __end_tp_report 03:17:31 INFO - PROCESS | 29051 | __start_cc_report 03:17:31 INFO - PROCESS | 29051 | _x_x_mozilla_cycle_collect,382 03:17:31 INFO - PROCESS | 29051 | __end_cc_report 03:17:31 INFO - PROCESS | 29051 | __startTimestamp1467109051720__endTimestamp 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | ------- Summary: start ------- 03:17:31 INFO - PROCESS | 29051 | Number of tests: 6 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | [#0] dojo.html Cycles:165 Average:4903.08 Median:5041.34 stddev:633.89 (12.6%) stddev-sans-first:610.36 03:17:31 INFO - PROCESS | 29051 | Values: 2635.5 2690.1 2707.4 2725.4 2727.6 4903.1 4917.3 4963.3 4970.2 5035.5 4902.2 4984.0 4989.9 4991.3 5030.8 4489.6 4535.8 4656.2 4664.0 4674.6 557.9 4430.9 4477.7 4518.3 4576.2 4548.2 4578.5 4581.4 4586.0 4600.6 4594.0 4601.8 4603.3 4613.1 4657.7 4448.8 4513.4 4521.3 4525.0 4528.2 4868.9 4926.1 4994.8 5001.9 5081.3 5304.0 5364.0 5381.8 5383.9 5384.6 5378.3 5448.7 5459.8 5461.2 5530.2 5011.7 5014.0 5018.4 5041.3 5089.6 5306.5 5421.1 5484.3 5501.4 5512.4 5252.3 5269.6 5269.9 5295.7 5314.5 5419.3 5423.2 5426.0 5434.6 5487.0 5068.7 5215.4 5232.9 5268.5 5349.6 5245.7 5263.4 5275.1 5281.8 5290.9 4559.7 4568.0 4572.6 4589.7 4602.9 3841.0 3915.7 3921.1 3936.8 3956.9 4615.6 4642.8 4649.4 4652.1 4696.0 5432.4 5433.9 5435.6 5459.6 5478.5 4533.3 4571.5 4585.0 4586.2 4603.1 4765.0 4786.1 4790.0 4823.3 4840.2 4934.1 4965.8 4971.9 4987.0 5013.3 5252.8 5259.8 5309.4 5316.4 5328.8 4978.3 4979.9 4981.7 4984.4 5039.9 5137.0 5245.0 5257.1 5260.2 5261.6 5260.4 5274.7 5323.5 5343.9 5352.4 5132.5 5135.6 5137.0 5155.8 5156.9 5045.3 5131.0 5145.0 5157.2 5163.4 5128.7 5164.7 5175.9 5194.4 5216.1 5290.7 5298.3 5310.3 5311.5 5365.0 4988.2 5110.9 5139.1 5189.2 5192.7 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | [#1] ext.html Cycles:180 Average:49590.49 Median:36613.04 stddev:92352.16 (252.2%) stddev-sans-first:92537.79 03:17:31 INFO - PROCESS | 29051 | Values: 534.5 573.0 583.7 589.9 613.9 36274.3 37667.8 40674.8 40707.2 40734.6 40875.4 40963.8 41349.8 41372.2 41479.8 8025.5 8079.4 8092.0 8094.1 8129.5 7853.3 7951.4 8047.2 8069.5 8075.6 8030.2 8050.3 8077.6 8106.7 8107.7 7935.7 7980.0 7995.8 8007.0 8028.0 7963.1 7995.0 8070.9 8093.3 8097.5 29956.4 32450.4 32610.7 32817.7 32876.7 2968.8 2981.9 3073.4 3080.1 3577.6 28216.6 28896.4 29185.7 32161.4 32926.8 3482.2 3554.6 3592.6 3601.9 3602.9 270628.0 271580.0 273924.0 274106.0 274709.0 57506.0 58133.0 58253.0 58588.0 58607.7 33661.7 34515.1 34817.3 60177.4 60245.7 13116.6 13122.5 13197.9 13204.9 13266.8 10235.0 10285.5 10372.1 10394.7 10400.1 18366.7 18454.3 18483.9 18617.7 18773.0 7090.2 7164.2 7305.2 7312.7 7377.5 803.4 811.8 932.5 935.7 1048.2 26878.7 27014.2 27489.0 27520.2 27844.9 961.1 970.8 992.8 993.7 1078.8 14693.3 14772.8 14932.8 15091.3 15204.5 396057.0 396261.0 396831.0 400151.0 402090.0 51177.0 51381.0 51536.7 51553.0 51857.5 1179.2 1215.3 1217.2 1217.9 1225.6 26489.3 27058.9 27497.6 27548.9 27775.3 43376.8 43417.0 44234.0 44270.0 44281.8 364070.0 365785.0 367691.0 367766.0 367769.0 25900.2 25973.0 26128.0 26396.0 26443.0 40117.4 42316.8 43573.3 43739.3 43843.8 35896.5 36331.0 36522.8 36642.8 37004.6 36453.0 36583.3 36948.6 36983.4 37022.7 35428.6 35910.0 36037.6 36729.6 36801.4 32287.5 32656.5 32703.3 32898.3 33100.7 25380.5 25569.2 25653.4 25709.9 26091.7 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | [#2] jquery.html Cycles:180 Average:23803.84 Median:25435.62 stddev:63129.96 (248.2%) stddev-sans-first:63282.54 03:17:31 INFO - PROCESS | 29051 | Values: 373.7 374.6 376.9 385.9 387.7 15554.7 16855.3 17050.2 17387.4 17395.8 15401.4 16231.5 16511.6 16540.1 16583.3 5100.5 5269.1 5306.5 5315.0 5319.3 3673.8 5092.4 5749.0 6039.6 6042.9 6118.1 6125.2 6131.4 6142.3 6158.5 5016.2 5331.5 5346.3 5367.4 5392.7 5199.6 5203.1 5259.4 5265.6 5288.4 18138.0 19295.4 19329.1 19914.9 20249.4 1892.4 1955.3 1964.3 2087.5 2327.5 9134.8 9160.4 9312.2 9373.8 9532.7 1774.1 1784.1 1795.5 1806.7 1818.4 46388.0 68209.0 68924.7 69261.3 70103.6 9817.3 10033.8 10088.9 10171.5 10331.5 13700.0 13756.7 13871.2 13887.7 13937.0 7067.0 7191.4 7253.8 7282.2 7344.9 6768.1 6787.6 6814.7 6855.7 6863.1 4243.3 4305.1 4318.5 4335.6 4483.2 1598.7 1641.9 1835.8 1840.2 1894.4 790.7 820.9 893.3 909.1 961.3 16121.0 16393.8 16760.4 16767.2 16982.6 861.6 872.1 888.8 898.9 921.4 8954.6 9459.8 9468.0 9475.1 9534.8 374595.1 377867.0 384487.0 388619.0 389344.0 67787.3 73082.6 75275.2 75443.2 76576.2 899.6 899.8 903.4 916.7 924.8 15010.2 15394.2 15429.3 15676.0 15687.0 34056.5 35350.6 35482.0 36970.3 37716.8 47362.5 50677.5 50777.7 51015.5 51117.5 7863.8 7882.1 7888.7 7970.6 8102.3 11753.9 11813.7 12171.4 12231.4 12298.1 9460.5 9661.1 10024.1 10206.3 10533.1 6204.6 9343.7 10776.7 10799.7 10809.0 10114.5 10133.5 10337.7 10458.2 10697.8 7942.4 7989.0 8021.7 8055.3 8075.4 10151.6 10196.1 10212.9 10238.6 10672.8 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | [#3] mootools.html Cycles:180 Average:5345.13 Median:4757.07 stddev:3008.47 (63.2%) stddev-sans-first:3002.00 03:17:31 INFO - PROCESS | 29051 | Values: 1360.2 1417.5 1474.2 1666.8 1677.4 7057.9 7803.7 7914.4 8342.3 8370.4 8001.5 8260.1 8327.8 8332.0 8337.7 2224.8 2261.0 2261.5 2263.6 2267.0 2148.1 2149.5 2156.2 2164.6 2206.6 2180.5 2190.7 2198.3 2202.8 2204.0 2079.5 2180.9 2202.1 2206.0 2227.2 2167.6 2204.0 2206.2 2210.2 2215.9 8261.9 8265.5 8302.4 8339.4 8384.9 4723.5 4899.2 4903.7 4903.9 4954.2 2909.8 3002.1 3004.5 3014.1 3045.9 970.3 1004.7 1016.6 1776.7 1813.1 11068.0 11192.5 11246.0 11263.8 11285.7 4112.5 4197.3 4284.5 4295.7 4302.6 8912.6 8913.6 8930.4 8940.9 8949.1 4744.0 4754.5 4756.9 4757.2 4763.4 3902.0 4243.7 4365.0 4432.4 4442.5 3796.5 3837.3 3894.4 3935.9 3984.6 1236.5 1263.2 1268.6 1272.3 1275.5 801.2 811.2 815.7 827.8 846.4 5292.4 5489.1 5558.6 5648.3 5735.1 831.8 842.7 876.9 892.5 916.8 3292.3 3551.8 3836.2 3936.8 3937.4 9825.9 10235.4 10298.3 10301.3 10324.2 9567.8 10044.4 10067.2 10159.2 10165.5 7381.1 7518.3 7748.1 7788.1 7807.5 5659.8 5734.9 5750.3 5761.7 5943.0 9294.0 9297.4 9411.4 9503.3 9575.2 9203.3 9438.8 9675.1 9714.8 9776.7 6484.7 6935.8 6942.4 7085.8 7180.2 7760.4 7789.2 7853.9 7932.1 7943.7 6584.5 6755.9 6851.7 6875.8 6991.5 7034.8 7057.3 7073.5 7162.8 7183.6 6159.2 6368.8 6390.2 6410.3 6427.7 4457.5 4495.4 4517.0 4518.2 4619.8 4498.8 4509.8 4613.5 4643.1 4661.4 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | [#4] prototype.html Cycles:180 Average:4322.93 Median:4790.85 stddev:1251.87 (26.1%) stddev-sans-first:1218.51 03:17:31 INFO - PROCESS | 29051 | Values: 304.9 313.1 316.8 318.8 321.1 4927.3 5019.6 5083.9 5165.4 5190.4 5050.2 5118.7 5139.6 5155.3 5161.5 4002.7 4023.3 4030.6 4030.7 4048.2 3938.9 4034.2 4036.9 4050.8 4074.3 3976.3 3994.2 3996.3 4005.9 4008.5 3993.8 4026.4 4046.3 4047.2 4052.7 3561.2 3591.1 3592.1 3602.4 3618.3 4779.6 4957.4 4968.9 4993.7 5088.8 4553.2 4574.8 4588.7 4596.4 4597.7 5362.0 5371.4 5376.9 5379.2 5408.8 3517.8 3745.3 3771.5 3790.5 3901.3 5593.8 5623.4 5623.8 5636.7 5672.4 3829.3 3839.7 3853.9 3865.5 3869.3 3859.9 3870.9 3931.2 3931.5 3949.2 4432.5 4461.7 4470.9 4474.4 4480.7 5330.3 5347.3 5350.5 5356.3 5379.2 1287.9 1334.7 1367.4 1369.7 1373.7 857.8 864.6 874.6 880.3 884.9 4219.7 4219.7 4252.0 4283.9 4292.8 4833.3 4850.5 4890.7 4973.7 4986.6 4256.3 4259.6 4262.9 4267.9 4334.7 2512.1 2602.9 2633.9 2657.1 2665.8 4591.3 4648.7 4671.5 4686.9 4716.3 4907.9 5057.8 5071.9 5080.0 5088.5 4505.6 4532.0 4606.6 4651.0 4667.5 4866.6 4885.6 4916.4 4921.2 4969.3 4802.1 4813.4 4842.8 4883.4 4883.4 4810.7 5264.2 5286.5 5288.7 5296.8 3864.2 3929.4 3945.4 3952.8 3973.2 5090.5 5635.6 5640.1 5644.5 5651.0 5300.9 5333.1 5342.5 5348.5 5373.1 5277.0 5296.4 5299.4 5312.5 5353.2 5094.7 5223.4 5252.3 5279.4 5307.9 5346.9 5375.9 5391.3 5402.2 5406.5 5266.9 5289.8 5325.2 5349.9 5356.4 03:17:31 INFO - PROCESS | 29051 | 03:17:31 INFO - PROCESS | 29051 | [#5] yui.html Cycles:180 Average:16735.08 Median:581.84 stddev:23451.57 (4030.6%) stddev-sans-first:23486.46 03:17:31 INFO - PROCESS | 29051 | Values: 700.9 710.8 724.8 749.4 755.3 11689.9 11874.9 12050.8 12715.4 12763.6 13103.4 13190.5 13317.6 13344.3 13358.9 625.8 766.6 781.9 797.1 797.6 786.0 795.1 795.2 798.3 802.8 845.5 847.0 848.1 849.8 849.9 833.5 841.3 842.7 842.8 845.0 610.8 611.0 614.2 614.3 614.6 12025.7 12150.9 12201.8 12251.9 12259.8 13851.2 14064.0 14081.3 14203.1 14494.1 10409.5 10428.2 10569.4 10756.5 10795.7 4349.3 4372.1 4372.8 4375.7 4458.7 58952.7 59369.7 59512.7 59689.0 59907.0 10385.5 10467.7 10548.2 10641.1 10729.8 17272.5 17948.4 17955.6 17969.5 17995.3 6980.6 7189.4 7265.4 7282.9 7344.1 3778.8 3807.0 3824.4 3863.6 3894.0 3055.5 3127.5 3164.9 3169.0 3185.9 538.5 544.0 546.8 553.1 562.9 552.5 575.0 575.6 593.7 605.4 7076.8 7203.4 7273.0 7329.7 7532.2 557.7 564.2 578.9 578.9 584.8 3455.2 3530.2 3576.9 3588.8 3596.4 86849.0 88810.0 89464.6 92374.0 94779.0 62311.0 76798.6 77279.0 77525.6 78959.6 69121.0 69505.7 70304.3 70573.6 71296.3 6670.4 6744.4 6782.2 6821.2 6904.0 40779.4 41382.6 42223.0 42529.4 43217.1 53174.2 60452.7 60757.0 61398.4 61988.7 8844.1 9130.5 9311.6 9368.2 9579.3 9641.5 9820.3 11932.2 12304.2 12486.1 10457.2 10522.2 10808.5 11099.3 11533.3 11747.8 11777.9 11778.4 11844.2 11964.5 10710.8 10776.9 10845.4 11035.7 11196.4 9315.1 9359.0 9401.3 9523.1 9748.6 9099.3 9188.5 9371.3 9622.8 9661.8 03:17:31 INFO - PROCESS | 29051 | -------- Summary: end -------- 03:17:31 INFO - PROCESS | 29051 | 03:17:32 INFO - TEST-INFO | 29051: exit 0 03:17:32 INFO - TEST-OK | dromaeo_css | took 1117505ms 03:17:32 INFO - TEST-START | kraken 03:17:32 INFO - operating with platform_type : linux_ 03:17:32 INFO - Initialising browser for kraken test... 03:17:32 INFO - TEST-INFO | started process 29293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9KdXh/profile http://localhost:40143/getInfo.html) 03:17:37 INFO - PROCESS | 29293 | __metrics Screen width/height:1600/1200 03:17:37 INFO - PROCESS | 29293 | colorDepth:24 03:17:37 INFO - PROCESS | 29293 | Browser inner width/height: 1024/697 03:17:37 INFO - PROCESS | 29293 | __metrics 03:17:38 ERROR - PROCESS | 29293 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:17:39 INFO - TEST-INFO | 29293: exit 0 03:17:39 INFO - Browser initialized. 03:17:39 INFO - Running cycle 1/1 for kraken test... 03:17:39 INFO - TEST-INFO | started process 29413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn9KdXh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:51 INFO - PROCESS | 29413 | RSS: Main: 186306560 03:17:51 INFO - PROCESS | 29413 | 03:17:54 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:55 INFO - PROCESS | 29413 | RSS: Main: 190169088 03:17:55 INFO - PROCESS | 29413 | 03:17:57 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-dft) 03:17:58 INFO - PROCESS | 29413 | RSS: Main: 189784064 03:17:58 INFO - PROCESS | 29413 | 03:18:01 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-fft) 03:18:02 INFO - PROCESS | 29413 | RSS: Main: 185819136 03:18:02 INFO - PROCESS | 29413 | 03:18:04 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator) 03:18:04 INFO - PROCESS | 29413 | RSS: Main: 186236928 03:18:04 INFO - PROCESS | 29413 | 03:18:07 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:18:07 INFO - PROCESS | 29413 | RSS: Main: 186830848 03:18:07 INFO - PROCESS | 29413 | 03:18:11 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom) 03:18:11 INFO - PROCESS | 29413 | RSS: Main: 186990592 03:18:11 INFO - PROCESS | 29413 | 03:18:15 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate) 03:18:15 INFO - PROCESS | 29413 | RSS: Main: 184279040 03:18:15 INFO - PROCESS | 29413 | 03:18:18 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial) 03:18:19 INFO - PROCESS | 29413 | RSS: Main: 185356288 03:18:19 INFO - PROCESS | 29413 | 03:18:21 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:18:21 INFO - PROCESS | 29413 | RSS: Main: 185479168 03:18:21 INFO - PROCESS | 29413 | 03:18:23 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:18:24 INFO - PROCESS | 29413 | RSS: Main: 186019840 03:18:24 INFO - PROCESS | 29413 | 03:18:26 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:27 INFO - PROCESS | 29413 | RSS: Main: 186499072 03:18:27 INFO - PROCESS | 29413 | 03:18:29 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:30 INFO - PROCESS | 29413 | RSS: Main: 186961920 03:18:30 INFO - PROCESS | 29413 | 03:18:33 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:34 INFO - PROCESS | 29413 | RSS: Main: 186863616 03:18:34 INFO - PROCESS | 29413 | 03:18:35 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40143/tests/kraken/driver.html?testName=ai-astar) 03:18:36 INFO - PROCESS | 29413 | RSS: Main: 187850752 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | __start_tp_report 03:18:36 INFO - PROCESS | 29413 | _x_x_mozilla_page_load 03:18:36 INFO - PROCESS | 29413 | _x_x_mozilla_page_load_details 03:18:36 INFO - PROCESS | 29413 | |i|pagename|runs| 03:18:36 INFO - PROCESS | 29413 | |0;ai-astar;106;116;108;116;116;118;114;114;114;114 03:18:36 INFO - PROCESS | 29413 | |1;audio-beat-detection;159;140;154;188;134;164;164;133;199;136 03:18:36 INFO - PROCESS | 29413 | |2;audio-dft;163;166;174;163;163;163;164;163;162;161 03:18:36 INFO - PROCESS | 29413 | |3;audio-fft;75;76;77;149;78;78;76;76;159;78 03:18:36 INFO - PROCESS | 29413 | |4;audio-oscillator;86;86;141;87;87;87;131;88;89;141 03:18:36 INFO - PROCESS | 29413 | |5;imaging-gaussian-blur;117;118;119;117;119;120;120;119;117;118 03:18:36 INFO - PROCESS | 29413 | |6;imaging-darkroom;149;151;149;148;147;148;149;148;151;148 03:18:36 INFO - PROCESS | 29413 | |7;imaging-desaturate;96;95;95;96;95;101;96;95;96;95 03:18:36 INFO - PROCESS | 29413 | |8;json-parse-financial;63;64;63;63;64;64;62;62;65;64 03:18:36 INFO - PROCESS | 29413 | |9;json-stringify-tinderbox;64;64;65;65;66;66;65;65;65;65 03:18:36 INFO - PROCESS | 29413 | |10;stanford-crypto-aes;87;82;82;84;83;83;84;81;96;89 03:18:36 INFO - PROCESS | 29413 | |11;stanford-crypto-ccm;132;132;129;140;132;134;148;137;140;132 03:18:36 INFO - PROCESS | 29413 | |12;stanford-crypto-pbkdf2;166;167;167;173;167;171;165;171;170;170 03:18:36 INFO - PROCESS | 29413 | |13;stanford-crypto-sha256-iterative;68;68;72;67;66;67;72;67;67;69 03:18:36 INFO - PROCESS | 29413 | __end_tp_report 03:18:36 INFO - PROCESS | 29413 | __start_cc_report 03:18:36 INFO - PROCESS | 29413 | _x_x_mozilla_cycle_collect,944 03:18:36 INFO - PROCESS | 29413 | __end_cc_report 03:18:36 INFO - PROCESS | 29413 | __startTimestamp1467109116114__endTimestamp 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | ------- Summary: start ------- 03:18:36 INFO - PROCESS | 29413 | Number of tests: 14 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.75 (3.3%) stddev-sans-first:2.79 03:18:36 INFO - PROCESS | 29413 | Values: 106.0 116.0 108.0 116.0 116.0 118.0 114.0 114.0 114.0 114.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:161.50 stddev:22.78 (14.1%) stddev-sans-first:24.15 03:18:36 INFO - PROCESS | 29413 | Values: 159.0 140.0 154.0 188.0 134.0 164.0 164.0 133.0 199.0 136.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:3.68 (2.3%) stddev-sans-first:3.87 03:18:36 INFO - PROCESS | 29413 | Values: 163.0 166.0 174.0 163.0 163.0 163.0 164.0 163.0 162.0 161.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.50 stddev:32.67 (42.7%) stddev-sans-first:34.06 03:18:36 INFO - PROCESS | 29413 | Values: 75.0 76.0 77.0 149.0 78.0 78.0 76.0 76.0 159.0 78.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:87.00 stddev:24.57 (28.2%) stddev-sans-first:25.34 03:18:36 INFO - PROCESS | 29413 | Values: 86.0 86.0 141.0 87.0 87.0 87.0 131.0 88.0 89.0 141.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:119.00 stddev:1.17 (1.0%) stddev-sans-first:1.13 03:18:36 INFO - PROCESS | 29413 | Values: 117.0 118.0 119.0 117.0 119.0 120.0 120.0 119.0 117.0 118.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.32 (0.9%) stddev-sans-first:1.39 03:18:36 INFO - PROCESS | 29413 | Values: 149.0 151.0 149.0 148.0 147.0 148.0 149.0 148.0 151.0 148.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.50 stddev:1.83 (1.9%) stddev-sans-first:1.94 03:18:36 INFO - PROCESS | 29413 | Values: 96.0 95.0 95.0 96.0 95.0 101.0 96.0 95.0 96.0 95.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 03:18:36 INFO - PROCESS | 29413 | Values: 63.0 64.0 63.0 63.0 64.0 64.0 62.0 62.0 65.0 64.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 03:18:36 INFO - PROCESS | 29413 | Values: 64.0 64.0 65.0 65.0 66.0 66.0 65.0 65.0 65.0 65.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:4.53 (5.4%) stddev-sans-first:4.76 03:18:36 INFO - PROCESS | 29413 | Values: 87.0 82.0 82.0 84.0 83.0 83.0 84.0 81.0 96.0 89.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:135.50 stddev:5.70 (4.2%) stddev-sans-first:5.89 03:18:36 INFO - PROCESS | 29413 | Values: 132.0 132.0 129.0 140.0 132.0 134.0 148.0 137.0 140.0 132.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:170.00 stddev:2.63 (1.5%) stddev-sans-first:2.60 03:18:36 INFO - PROCESS | 29413 | Values: 166.0 167.0 167.0 173.0 167.0 171.0 165.0 171.0 170.0 170.0 03:18:36 INFO - PROCESS | 29413 | 03:18:36 INFO - PROCESS | 29413 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.11 (3.1%) stddev-sans-first:2.24 03:18:36 INFO - PROCESS | 29413 | Values: 68.0 68.0 72.0 67.0 66.0 67.0 72.0 67.0 67.0 69.0 03:18:36 INFO - PROCESS | 29413 | -------- Summary: end -------- 03:18:36 INFO - PROCESS | 29413 | 03:18:37 INFO - TEST-INFO | 29413: exit 0 03:18:37 INFO - TEST-OK | kraken | took 64593ms 03:18:37 INFO - SUITE-END | took 1182s 03:18:37 INFO - Completed test suite (00:19:42) 03:18:37 INFO - javascript benchmark 03:18:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6517.279302480325, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.499255141523, 2690.0988168963395, 2707.4314393977265, 2725.4004119093793, 2727.6317697110885, 4903.068417000767, 4917.262410638402, 4963.329950456697, 4970.229614409768, 5035.496450354972, 4902.240152776317, 4983.975080124595, 4989.850304490862, 4991.326170966928, 5030.798768049273, 4489.595936365735, 4535.7958891849785, 4656.185167595674, 4663.976680116594, 4674.626029917616, 557.8694487068793, 4430.867073987785, 4477.731336119827, 4518.254488009491, 4576.153411618861, 4548.204064288753, 4578.519255478193, 4581.381513495702, 4585.977070114662, 4600.608948239404, 4593.977030114861, 4601.7699115044115, 4603.309503574457, 4613.123506533748, 4657.650676199265, 4448.755318457484, 4513.435820522434, 4521.276595744698, 4524.954750452486, 4528.18492671319, 4868.902621947541, 4926.088673595396, 4994.800207991676, 5001.874953126165, 5081.339425874649, 5304.0, 5364.034473794715, 5381.784728610851, 5383.946160538384, 5384.6499977501335, 5378.300820893259, 5448.727563621843, 5459.808906688287, 5461.15352120422, 5530.170474428827, 5011.749412529359, 5013.974930125362, 5018.422881368653, 5041.344625198774, 5089.643724939218, 5306.469353064663, 5421.078416669096, 5484.287042684426, 5501.4223506532035, 5512.3660779010925, 5252.264682944391, 5269.604779641542, 5269.868253293698, 5295.735213239323, 5314.468553144655, 5419.295491586147, 5423.18652202165, 5425.972870135703, 5434.592405569519, 5486.972565137149, 5068.721220332917, 5215.400228973641, 5232.947670523322, 5268.525832675077, 5349.625526213128, 5245.7114858683135, 5263.3947096083675, 5275.103232450492, 5281.762320695578, 5290.894182116336, 4559.658025648089, 4568.040711450632, 4572.611328037087, 4589.747563884019, 4602.861914142581, 3840.9807950960626, 3915.7063220258597, 3921.0589458530317, 3936.842526298916, 3956.8615098471414, 4615.584597386184, 4642.791074401593, 4649.442066951988, 4652.092841895866, 4696.037312351028, 5432.402435732066, 5433.864153396117, 5435.619506634498, 5459.645123067067, 5478.506934375925, 4533.32000199966, 4571.542845715402, 4584.977075114603, 4586.197415452282, 4603.125406172817, 4765.0, 4786.114568804782, 4789.976050119727, 4823.252395878644, 4840.249761287007, 4934.087193869145, 4965.776540055634, 4971.9005619886675, 4986.950130498649, 5013.273075404119, 5252.816151434834, 5259.8422047338645, 5309.36287645485, 5316.388615309289, 5328.813491527778, 4978.2781496682055, 4979.925301120414, 4981.701097934136, 4984.352034235526, 5039.924401134059, 5137.023965446553, 5244.973775131252, 5257.053730328577, 5260.184671375943, 5261.631685781958, 5260.44765299638, 5274.657147285414, 5323.520883120537, 5343.866403339947, 5352.41123476425, 5132.538071573576, 5135.589152867687, 5137.0, 5155.819546315861, 5156.922646160386, 5045.344105266292, 5131.025105229995, 5144.9742751286, 5157.174852023658, 5163.380394352552, 5128.666636668605, 5164.715940623302, 5175.896482070262, 5194.428612852659, 5216.087184742731, 5290.65610735301, 5298.28473156119, 5310.336207974004, 5311.49540793624, 5365.0, 4988.152014157529, 5110.9488905110475, 5139.100657384868, 5189.247559103834, 5192.714400707997], "value": 4862.4953578329305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.472563588942, 572.9972548040928, 583.6527266276564, 589.9174115623811, 613.9171211886394, 36274.27451450973, 37667.81166094169, 40674.796626016905, 40707.18585628286, 40734.59265407345, 40875.386869196984, 40963.79518102413, 41349.79325103378, 41372.17255654885, 41479.79260103703, 8025.478343907642, 8079.394045446586, 8091.959540202291, 8094.069182044082, 8129.512229266234, 7853.2539408756365, 7951.40364472664, 8047.195280471935, 8069.515829050276, 8075.555844428554, 8030.156833532483, 8050.275475207231, 8077.555734434603, 8106.675732970674, 8107.716229931953, 7935.722249721261, 7980.042394912648, 7995.840083198304, 8007.039155301343, 8028.0, 7963.124056353797, 7995.040595128564, 8070.9192908071345, 8093.312068474187, 8097.473664211808, 29956.400871982656, 32450.350992980246, 32610.673893261002, 32817.67182328194, 32876.6712332876, 2968.83671398073, 2981.940361192764, 3073.3853229354218, 3080.1221651829346, 3577.606463289036, 28216.576751348744, 28896.422071558452, 29185.708142918724, 32161.356772864412, 32926.83536582326, 3482.21650128719, 3554.59122200945, 3592.604813470516, 3601.8559257629663, 3602.9279414411826, 270628.0, 271580.0, 273924.0, 274106.0, 274708.999999998, 57506.0, 58133.0, 58253.0, 58588.0, 58607.706961465774, 33661.66338336634, 34515.13712157166, 34817.30365392678, 60177.38935663874, 60245.698771505864, 13116.606501804961, 13122.540711075066, 13197.868021319857, 13204.867951320555, 13266.800997985038, 10235.0, 10285.485725713685, 10372.11836993849, 10394.740131496774, 10400.115990140772, 18366.724499132524, 18454.26182952694, 18483.87435444941, 18617.720734189, 18773.0, 7090.184628767758, 7164.21193668696, 7305.159906610702, 7312.707491700379, 7377.483576149618, 803.3894240377356, 811.8173410982599, 932.4591736792644, 935.6713516523334, 1048.2295512798087, 26878.731212687624, 27014.1895743128, 27489.0, 27520.17439476819, 27844.860775695994, 961.1445813226235, 970.752458123174, 992.7766252593109, 993.6869885985891, 1078.8489611454402, 14693.338799754038, 14772.778408323884, 14932.776008359884, 15091.320890559951, 15204.46784362542, 396057.0, 396261.0, 396831.0, 400151.0, 402090.0, 51177.0, 51381.0, 51536.742316288175, 51553.0, 51857.48142518602, 1179.2217136689915, 1215.3376409856648, 1217.1540779158577, 1217.8843009914044, 1225.5649244518247, 26489.33776655599, 27058.864705676344, 27497.587536186573, 27548.862255688593, 27775.30561735973, 43376.78311608422, 43417.0, 44234.0, 44270.0, 44281.778591106835, 364070.0, 365785.0, 367691.0, 367766.0, 367769.0, 25900.22299331023, 25973.0, 26128.0, 26396.0, 26443.0, 40117.398239027025, 42316.78841605772, 43573.34639980339, 43739.34390984074, 43843.78078109589, 35896.46155307725, 36331.0, 36522.8173859129, 36642.81678591697, 37004.62995370012, 36453.0, 36583.26833463262, 36948.630513694516, 36983.44524832076, 37022.70420535268, 35428.64571354254, 35910.0, 36037.639623604475, 36729.63270367262, 36801.447978279815, 32287.51568726424, 32656.51015234726, 32703.34593308168, 32898.34203315968, 33100.66899330976, 25380.492390152463, 25569.23292301234, 25653.358666032753, 25709.871450642626, 26091.739082608932], "value": 17686.745508234704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.72531189575676, 374.6122762940357, 376.91142581493347, 385.9421086836976, 387.7402140565821, 15554.688906221869, 16855.325786968522, 17050.232739526706, 17387.39144129956, 17395.82604173958, 15401.3839446422, 16231.513054608351, 16511.587210319747, 16540.09029503377, 16583.253753581088, 5100.540951314381, 5269.130593452095, 5306.522412982831, 5315.01672190646, 5319.308489896327, 3673.797941113238, 5092.414372347172, 5748.971255143719, 6039.637621742688, 6042.939570604303, 6118.11287363332, 6125.234345706786, 6131.3562075982045, 6142.324344322144, 6158.476529494998, 5016.222485514732, 5331.520163185312, 5346.331708536433, 5367.43641917597, 5392.676439413648, 5199.558037566811, 5203.089459344637, 5259.395169555473, 5265.631405801595, 5288.444713305086, 18138.0, 19295.4211373659, 19329.130189141382, 19914.900425497926, 20249.39251822448, 1892.3660573707825, 1955.3351860367402, 1964.3223088034606, 2087.5407410369694, 2327.487952650414, 9134.81730365389, 9160.35877488576, 9312.161905428544, 9373.812523749486, 9532.714018579454, 1774.1395423219728, 1784.1079460269866, 1795.4703362508092, 1806.7018941874576, 1818.4453741608804, 46388.0, 68208.97686534756, 68924.65537672279, 69261.30738692598, 70103.64948175277, 9817.312788104908, 10033.849492257623, 10088.899111008943, 10171.54228059739, 10331.535080921376, 13700.0, 13756.724865502634, 13871.167729936236, 13887.652808679662, 13937.0, 7066.964665176642, 7191.424686025105, 7253.818654533573, 7282.235365286569, 7344.889826652605, 6768.08630834831, 6787.592744435349, 6814.693338799766, 6855.6572171391235, 6863.073485079551, 4243.321068629005, 4305.117450922553, 4318.481782186095, 4335.612603966701, 4483.237849565582, 1598.6802639472153, 1641.9096949667883, 1835.7797064352362, 1840.1811194018533, 1894.4411398637435, 790.6521130702472, 820.8522465956186, 893.2898345815092, 909.077286554148, 961.2550273538064, 16121.032738035756, 16393.754093688603, 16760.413385531447, 16767.161641917854, 16982.57543561421, 861.6338056326036, 872.0988047174917, 888.8000199954959, 898.883145191121, 921.4149015375151, 8954.552272386354, 9459.810803783887, 9468.0, 9475.052494750607, 9534.761630959281, 374595.12702436314, 377867.0, 384487.0, 388619.0, 389344.0, 67787.3221267781, 73082.63458682672, 75275.24724752683, 75443.24556754362, 76576.23423765802, 899.6131663384676, 899.7705585075764, 903.3721563513295, 916.6562539047857, 924.8104138651426, 15010.174440405883, 15394.230288485754, 15429.305681244146, 15676.0, 15687.0, 34056.48915266224, 35350.64649353473, 35482.0, 36970.260594788495, 37716.81141594274, 47362.52637473581, 50677.49322506728, 50777.74611126921, 51015.489845101074, 51117.48882511276, 7863.764087077397, 7882.132965373919, 7888.723894663659, 7970.561619111005, 8102.270795628422, 11753.882461175279, 11813.704657383634, 12171.391430428266, 12231.388430578258, 12298.139130260795, 9460.526973651153, 9661.13049825519, 10024.14794742455, 10206.336588121749, 10533.104686101768, 6204.5967012144065, 9343.71968840936, 10776.67669969902, 10799.67600971972, 10809.0, 10114.494275286059, 10133.543990520297, 10337.74155646115, 10458.163346932075, 10697.786044279226, 7942.364610831004, 7989.041315042232, 8021.679132834622, 8055.315298199719, 8075.353971682134, 10151.64469243573, 10196.13332866685, 10212.948935255276, 10238.641647542301, 10672.83990740155], "value": 8190.407809650489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.1838896662005, 1417.4755340524005, 1474.2407660055067, 1666.7749853769737, 1677.3793696332352, 7057.894131588017, 7803.687852485901, 7914.445988780788, 8342.290905273052, 8370.372222083346, 8001.519908805476, 8260.091389947102, 8327.750167494969, 8331.958340208306, 8337.749867503984, 2224.7663995280504, 2261.027758064032, 2261.547690461914, 2263.581237471065, 2266.9773302267013, 2148.0655914677086, 2149.5271040371094, 2156.223759446598, 2164.5562659654734, 2206.569718904814, 2180.509385388291, 2190.69330293759, 2198.329509499602, 2202.768709285526, 2203.9559208815813, 2079.4697352175176, 2180.8582442141287, 2202.130158587349, 2205.977940220593, 2227.220472834495, 2167.6098302305577, 2203.9559208815895, 2206.1837120265604, 2210.160139147114, 2215.9335219943428, 8261.917380826235, 8265.504069755834, 8302.418830681854, 8339.416240863142, 8384.916150838475, 4723.504032076651, 4899.216125419915, 4903.730294833783, 4903.926441103386, 4954.182559877616, 2909.839958802265, 3002.0993701889565, 3004.534297183918, 3014.0807053848566, 3045.923851903698, 970.3013830042429, 1004.6634377483551, 1016.6340117557673, 1776.733489976501, 1813.102514255452, 11068.0, 11192.496337664825, 11246.044086252678, 11263.774724505463, 11285.661430157108, 4112.485939257593, 4197.349410841263, 4284.464441944757, 4295.699301048897, 4302.634276086567, 8912.598933048028, 8913.643454261757, 8930.419522731132, 8940.910590894007, 8949.060348663426, 4743.976280118577, 4754.4532378776885, 4756.9286460703115, 4757.215059515211, 4763.356946812136, 3902.0, 4243.745375277494, 4365.039691267916, 4432.3794668746405, 4442.4669039715445, 3796.487474190949, 3837.2901013312626, 3894.3963685628773, 3935.878274691699, 3984.581618929971, 1236.5424792826711, 1263.1789336931067, 1268.6447794617523, 1272.2557303977278, 1275.5025540039392, 801.1988011988012, 811.2414892075927, 815.6859609050558, 827.8302947895667, 846.3736834742247, 5292.391374991848, 5489.1217405214975, 5558.555315574825, 5648.322201335866, 5735.082386818172, 831.7920519870032, 842.7092653034694, 876.8640860666607, 892.4779004282567, 916.8074704312036, 3292.3415316936707, 3551.751377403609, 3836.1943991761486, 3936.803159842054, 3937.3503371943307, 9825.852612210823, 10235.43705096212, 10298.279120461495, 10301.330413523097, 10324.22568307365, 9567.760805979768, 10044.397336159855, 10067.244956628283, 10159.187265018929, 10165.4917254137, 7381.11426628808, 7518.323350898336, 7748.147703752583, 7788.065432148179, 7807.531548107132, 5659.773609055592, 5734.885302294014, 5750.281214848144, 5761.683107429131, 5943.049112142036, 9294.0, 9297.395669281475, 9411.388259763093, 9503.287253455881, 9575.23398128134, 9203.263738900738, 9438.811223775348, 9675.129238368581, 9714.75713107178, 9776.657816976656, 6484.675766211765, 6935.826604334932, 6942.444604431735, 7085.751998680022, 7180.1742799578715, 7760.379169666526, 7789.221077892392, 7853.921460785547, 7932.0878099017045, 7943.682252709827, 6584.4732421405215, 6755.898661519983, 6851.725930962905, 6875.7937261882225, 6991.510594258353, 7034.753783617549, 7057.258987806206, 7073.469489788184, 7162.820929476805, 7183.640817958976, 6159.168512250789, 6368.840778980562, 6390.169277993831, 6410.262819775786, 6427.678616069272, 4457.5096739358, 4495.43807024122, 4517.0, 4518.231900576844, 4619.769011549476, 4498.77506124699, 4509.804901700986, 4613.538646135359, 4643.071385722801, 4661.440627124767], "value": 4313.668457545394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.92834183966767, 313.0701815607645, 316.78775220602193, 318.8182735840571, 321.1009174311926, 4927.339236812117, 5019.623528235379, 5083.872903177423, 5165.431802501722, 5190.403103643087, 5050.217216331465, 5118.718470484131, 5139.563137133338, 5155.329807125077, 5161.509656582628, 4002.659109198422, 4023.295923213426, 4030.6170913763144, 4030.690025741631, 4048.170125124357, 3938.8818335449837, 4034.2334956358345, 4036.8788936331957, 4050.7569545827196, 4074.2869997750277, 3976.3439032559595, 3994.241094192109, 3996.3006473867104, 4005.8998525036964, 4008.498937632796, 3993.7803420811842, 4026.3759117336713, 4046.2514434829354, 4047.1872048926007, 4052.7365721228025, 3561.1809283864595, 3591.066322756102, 3592.1019745063736, 3602.3875941090078, 3618.2763447310645, 4779.593734532569, 4957.429895562021, 4968.850934471971, 4993.725345106018, 5088.821891233826, 4553.203189441868, 4574.771261436948, 4588.7476188809605, 4596.35651008859, 4597.724136551784, 5362.0, 5371.435999220064, 5376.91934620981, 5379.193121031837, 5408.755986123214, 3517.771344862576, 3745.325841348556, 3771.4719939208258, 3790.4503846942316, 3901.317269477858, 5593.832185034415, 5623.425440876561, 5623.831285061455, 5636.718164091779, 5672.432756724335, 3829.3490106681375, 3839.6736277416176, 3853.8843834685003, 3865.4781604483037, 3869.2648396804516, 3859.903502412406, 3870.8645197417954, 3931.233409485123, 3931.4863777445316, 3949.229900169497, 4432.534583868647, 4461.687681862303, 4470.865874023784, 4474.373587697725, 4480.708753930984, 5330.280412144389, 5347.278117454094, 5350.491703288181, 5356.276902618175, 5379.220013098079, 1287.8905293050195, 1334.726381091874, 1367.4325155060737, 1369.657585603599, 1373.684052667872, 857.8198578298502, 864.6368525219423, 874.6020560644891, 880.295763389286, 884.9469031858109, 4219.683523735732, 4219.746815191098, 4252.0, 4283.914321713548, 4292.828286868553, 4833.347498087714, 4850.490698476609, 4890.682105663121, 4973.651844370932, 4986.551210391082, 4256.255155347863, 4259.552746961586, 4262.936055959163, 4267.914641707211, 4334.696571240046, 2512.078260131001, 2602.895884164612, 2633.8814753336146, 2657.0700254910626, 2665.8267212631117, 4591.334256532784, 4648.721076735406, 4671.48613652498, 4686.929696054562, 4716.316134160527, 4907.852764417074, 5057.836697559582, 5071.949280507221, 5080.034793389244, 5088.542031217208, 4505.639548836085, 4531.954680453219, 4606.618014595675, 4651.046535460155, 4667.463241727177, 4866.586340161126, 4885.560299573055, 4916.385451818523, 4921.212605983025, 4969.279454479008, 4802.111609352281, 4813.374261346143, 4842.789302674331, 4883.3651625288485, 4883.389576302962, 4810.735409552368, 5264.236685680631, 5286.524212820865, 5288.735563221747, 5296.841094767163, 3864.246471937945, 3929.426225822091, 3945.4279129525485, 3952.782596957195, 3973.165635216637, 5090.516400941905, 5635.605507614428, 5640.097584386478, 5644.491995720241, 5651.0, 5300.867478312919, 5333.093374126331, 5342.519173274424, 5348.5186333230195, 5373.11343628297, 5277.0, 5296.41739408657, 5299.39057008449, 5312.495312945264, 5353.189575472908, 5094.681919726441, 5223.399309079505, 5252.2646829444675, 5279.39286982002, 5307.867303317448, 5346.919796202982, 5375.919361209663, 5391.32608423947, 5402.216678581663, 5406.486383793534, 5266.947330526799, 5289.7619607117, 5325.201219817059, 5349.919751203657, 5356.3572371315695], "value": 3926.2502248048872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9485771342986, 710.7512370670266, 724.7572063358774, 749.411711806232, 755.3126654744177, 11689.883101168996, 11874.940625296873, 12050.758984820299, 12715.42780574874, 12763.553275635355, 13103.410346534405, 13190.472381104768, 13317.600471985856, 13344.2660653664, 13358.93320533396, 625.8060001399558, 766.632016632017, 781.8709912864384, 797.1191833024511, 797.6450479536609, 785.968561257549, 795.1253621016864, 795.157133438557, 798.3094623150962, 802.7511471443842, 845.480029781686, 846.9830603387928, 848.0840692052599, 849.8385306791721, 849.9065102838683, 833.5373867503503, 841.3017195727532, 842.6882053640162, 842.7556008757452, 844.9957750211271, 610.8442347201435, 611.013213659936, 614.1586027142843, 614.2659521871366, 614.6158650843223, 12025.699357516132, 12150.939245303805, 12201.816972745415, 12251.93874030633, 12259.816102758467, 13851.16892986424, 14064.0, 14081.295935203301, 14203.076800007966, 14494.05788623736, 10409.479526023744, 10428.217883658755, 10569.41868197249, 10756.462176891124, 10795.730106747316, 4349.304111342201, 4372.103718737651, 4372.781360931941, 4375.737455752633, 4458.7324760514475, 58952.70523647354, 59369.7031514844, 59512.70243648754, 59689.0, 59907.0, 10385.480725963671, 10467.738306542245, 10548.208884333551, 10641.095506881848, 10729.785404292026, 17272.481825545256, 17948.37180698669, 17955.640887182184, 17969.460916172273, 17995.280188792563, 6980.581165130007, 7189.424846012306, 7265.382442492341, 7282.854342913112, 7344.118705755237, 3778.8110594470168, 3806.9619303807162, 3824.388097904322, 3863.594322596087, 3893.980530097331, 3055.4805683033937, 3127.4839651457255, 3164.857581408842, 3169.0492852144266, 3185.9362812743616, 538.5072658517491, 543.9646422982494, 546.7976848566057, 553.1343447504643, 562.8649124210242, 552.4558310064583, 575.0167214063914, 575.5827025406546, 593.7476572456688, 605.4429924469499, 7076.787696369117, 7203.423726101899, 7272.96363518179, 7329.706811727471, 7532.209118042636, 557.6626141184606, 564.1903867949505, 578.887117012187, 578.8986927287708, 584.7719389438123, 3455.1534873956043, 3530.223350862806, 3576.8926932192076, 3588.784672919633, 3596.3886139356373, 86849.0, 88810.0, 89464.55267723619, 92374.0, 94779.0, 62311.0, 76798.6160069196, 77279.0, 77525.61237193778, 78959.60520197477, 69121.0, 69505.65247173731, 70304.29695702977, 70573.64713176401, 71296.28703713001, 6670.39966403026, 6744.359285867835, 6782.220044694924, 6821.2155602106395, 6904.0, 40779.38830917598, 41382.586174137876, 42223.0, 42529.36205956975, 43217.135657287305, 53174.20238696345, 60452.6977365128, 60757.0, 61398.386016141056, 61988.69005655123, 8844.115588441104, 9130.543472826464, 9311.627534898527, 9368.203702685349, 9579.329446938647, 9641.469719165514, 9820.263480239153, 11932.22440541362, 12304.200226985216, 12486.125971182293, 10457.16342692598, 10522.158227341948, 10808.513616887416, 11099.334039957628, 11533.250338728292, 11747.765044699228, 11777.882221177679, 11778.352190629597, 11844.1709080367, 11964.490549099588, 10710.785784284426, 10776.946115269373, 10845.403502807421, 11035.724106897393, 11196.38419886914, 9315.115064068903, 9359.0, 9401.294902882175, 9523.095305945924, 9748.561314740995, 9099.272058235458, 9188.540572971458, 9371.250299976122, 9622.807543849223, 9661.758456038655], "value": 6422.655717401333, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 108.0, 116.0, 116.0, 118.0, 114.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 140.0, 154.0, 188.0, 134.0, 164.0, 164.0, 133.0, 199.0, 136.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 174.0, 163.0, 163.0, 163.0, 164.0, 163.0, 162.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 149.0, 78.0, 78.0, 76.0, 76.0, 159.0, 78.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 141.0, 87.0, 87.0, 87.0, 131.0, 88.0, 89.0, 141.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 117.0, 119.0, 120.0, 120.0, 119.0, 117.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 148.0, 147.0, 148.0, 149.0, 148.0, 151.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 101.0, 96.0, 95.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 62.0, 62.0, 65.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 82.0, 84.0, 83.0, 83.0, 84.0, 81.0, 96.0, 89.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 129.0, 140.0, 132.0, 134.0, 148.0, 137.0, 140.0, 132.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 167.0, 173.0, 167.0, 171.0, 165.0, 171.0, 170.0, 170.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 72.0, 67.0, 66.0, 67.0, 72.0, 67.0, 67.0, 69.0], "value": 68.3, "unit": "score"}]}]} 03:18:37 INFO - Return code: 0 03:18:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:18:37 ERROR - # TBPL SUCCESS # 03:18:37 INFO - Running post-action listener: _resource_record_post_action 03:18:37 INFO - ##### 03:18:37 INFO - ##### Finished run-tests step (success) 03:18:37 INFO - ##### 03:18:37 INFO - Running post-run listener: _resource_record_post_run 03:18:37 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 0; Write bytes: 554655744; Read time: 0; Write time: 689116 03:18:37 INFO - TinderboxPrint: CPU usage
13.5% 03:18:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:18:37 INFO - TinderboxPrint: I/O write bytes / time
554,655,744 / 689,116 03:18:37 INFO - TinderboxPrint: CPU idle
8,275.6 (86.4%) 03:18:37 INFO - TinderboxPrint: CPU user
1,238.0 (12.9%) 03:18:37 INFO - TinderboxPrint: Swap in / out
0 / 0 03:18:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253931520; Read time: 0; Write time: 385856 03:18:37 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 300724224; Read time: 0; Write time: 303260 03:18:38 INFO - Running post-run listener: _upload_blobber_files 03:18:38 INFO - Blob upload gear active. 03:18:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:38 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 03:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:18:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:41 INFO - (blobuploader) - INFO - Done attempting. 03:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:42 INFO - (blobuploader) - INFO - Done attempting. 03:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:43 INFO - (blobuploader) - INFO - Done attempting. 03:18:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:43 INFO - Return code: 0 03:18:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/267cd4fa116da23e0dfba15015e29d88d713f2870187f217bc2a0ba82d659ac8603fcdc76b9243b4de2448319d92cc7943bd200733f89fd43fed5332f3ffe5b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b202049db9a1d75626c8b81425a0b6e1eb51cdd2f1b8a9ffd10d8a816899913c8fb1e2af44e15045caf85f9c930cf654fd0f1b97a44f99639e704840b48da87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02046527c3d52af1996457f30f745a85c4c135c3cb9c646b2253aac333b69c216c8e5e5de6df71dc76f971b45e5d92c60624370b2fefba1eb6f36bb4a009ad94"} 03:18:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:43 INFO - Contents: 03:18:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/267cd4fa116da23e0dfba15015e29d88d713f2870187f217bc2a0ba82d659ac8603fcdc76b9243b4de2448319d92cc7943bd200733f89fd43fed5332f3ffe5b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b202049db9a1d75626c8b81425a0b6e1eb51cdd2f1b8a9ffd10d8a816899913c8fb1e2af44e15045caf85f9c930cf654fd0f1b97a44f99639e704840b48da87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02046527c3d52af1996457f30f745a85c4c135c3cb9c646b2253aac333b69c216c8e5e5de6df71dc76f971b45e5d92c60624370b2fefba1eb6f36bb4a009ad94"} 03:18:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:43 INFO - Copying logs to upload dir... 03:18:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.941999 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-28 03:18:42.876077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 03:18:42.879985) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/267cd4fa116da23e0dfba15015e29d88d713f2870187f217bc2a0ba82d659ac8603fcdc76b9243b4de2448319d92cc7943bd200733f89fd43fed5332f3ffe5b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b202049db9a1d75626c8b81425a0b6e1eb51cdd2f1b8a9ffd10d8a816899913c8fb1e2af44e15045caf85f9c930cf654fd0f1b97a44f99639e704840b48da87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02046527c3d52af1996457f30f745a85c4c135c3cb9c646b2253aac333b69c216c8e5e5de6df71dc76f971b45e5d92c60624370b2fefba1eb6f36bb4a009ad94"} build_url:https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/HjtQziD0RZC2oyJ6xscQfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/267cd4fa116da23e0dfba15015e29d88d713f2870187f217bc2a0ba82d659ac8603fcdc76b9243b4de2448319d92cc7943bd200733f89fd43fed5332f3ffe5b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b202049db9a1d75626c8b81425a0b6e1eb51cdd2f1b8a9ffd10d8a816899913c8fb1e2af44e15045caf85f9c930cf654fd0f1b97a44f99639e704840b48da87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02046527c3d52af1996457f30f745a85c4c135c3cb9c646b2253aac333b69c216c8e5e5de6df71dc76f971b45e5d92c60624370b2fefba1eb6f36bb4a009ad94"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 03:18:42.909552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:18:42.909872) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467107879.40907-903618694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:18:42.992694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 03:18:42.993002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 03:18:42.993281) ========= ========= Total master_lag: 0.18 =========