builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1464911782.08 results: success (0) buildid: 20160602143006 builduid: 9abe255c289f4eeab38fe4b7321a8100 revision: f76a0fdadbf053c3373961f9afbc966c011a50fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.085280) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.085699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.085971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.133801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.134054) ========= 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=1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 16:56:22-- 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% 220M=0s 2016-06-02 16:56:22 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120132 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.268641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.268950) ========= 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=1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.318442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:22.318804) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f76a0fdadbf053c3373961f9afbc966c011a50fe --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 f76a0fdadbf053c3373961f9afbc966c011a50fe --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=1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 16:56:22,614 truncating revision to first 12 chars 2016-06-02 16:56:22,614 Setting DEBUG logging. 2016-06-02 16:56:22,614 attempt 1/10 2016-06-02 16:56:22,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f76a0fdadbf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 16:56:22,929 unpacking tar archive at: fx-team-f76a0fdadbf0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:23.002599) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:23.002911) ========= script_repo_revision: f76a0fdadbf053c3373961f9afbc966c011a50fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:23.006235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:23.006508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 16:56:23.019048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-02 16:56:23.019325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:23 INFO - MultiFileLogger online at 20160602 16:56:23 in /builds/slave/test 16:56:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:56:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:23 INFO - {'append_to_log': False, 16:56:23 INFO - 'base_work_dir': '/builds/slave/test', 16:56:23 INFO - 'blob_upload_branch': 'Fx-Team', 16:56:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:23 INFO - 'branch': 'Fx-Team', 16:56:23 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:23 INFO - 'config_files': ('talos/linux_config.py',), 16:56:23 INFO - 'default_actions': ('clobber', 16:56:23 INFO - 'read-buildbot-config', 16:56:23 INFO - 'download-and-extract', 16:56:23 INFO - 'populate-webroot', 16:56:23 INFO - 'create-virtualenv', 16:56:23 INFO - 'install', 16:56:23 INFO - 'run-tests'), 16:56:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:23 INFO - 'download_minidump_stackwalk': True, 16:56:23 INFO - 'download_symbols': 'ondemand', 16:56:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:23 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:23 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:23 INFO - 'installer_path': 'installer.exe', 16:56:23 INFO - 'log_level': 'info', 16:56:23 INFO - 'log_name': 'talos', 16:56:23 INFO - 'log_to_console': True, 16:56:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:23 INFO - 'opt_config_files': (), 16:56:23 INFO - 'pip_index': False, 16:56:23 INFO - 'sps_profile': False, 16:56:23 INFO - 'sps_profile_interval': 0, 16:56:23 INFO - 'suite': 'dromaeojs-e10s', 16:56:23 INFO - 'system_bits': '32', 16:56:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:23 INFO - 'title': 'talos-linux64-ix-027', 16:56:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:23 INFO - 'use_talos_json': True, 16:56:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:23 INFO - 'work_dir': 'build'} 16:56:23 INFO - ##### 16:56:23 INFO - ##### Running clobber step. 16:56:23 INFO - ##### 16:56:23 INFO - Running pre-action listener: _resource_record_pre_action 16:56:23 INFO - Running main action method: clobber 16:56:23 INFO - rmtree: /builds/slave/test/build 16:56:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:24 INFO - Running post-action listener: _resource_record_post_action 16:56:24 INFO - ##### 16:56:24 INFO - ##### Finished clobber step (success) 16:56:24 INFO - ##### 16:56:24 INFO - ##### 16:56:24 INFO - ##### Running read-buildbot-config step. 16:56:24 INFO - ##### 16:56:24 INFO - Running pre-action listener: _resource_record_pre_action 16:56:24 INFO - Running main action method: read_buildbot_config 16:56:24 INFO - Using buildbot properties: 16:56:24 INFO - { 16:56:24 INFO - "project": "", 16:56:24 INFO - "product": "firefox", 16:56:24 INFO - "script_repo_revision": "production", 16:56:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:56:24 INFO - "repository": "", 16:56:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:56:24 INFO - "buildid": "20160602143006", 16:56:24 INFO - "pgo_build": "True", 16:56:24 INFO - "basedir": "/builds/slave/test", 16:56:24 INFO - "buildnumber": 803, 16:56:24 INFO - "slavename": "talos-linux64-ix-027", 16:56:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:56:24 INFO - "platform": "ubuntu64_hw", 16:56:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:56:24 INFO - "branch": "fx-team", 16:56:24 INFO - "repo_path": "integration/fx-team", 16:56:24 INFO - "revision": "f76a0fdadbf053c3373961f9afbc966c011a50fe", 16:56:24 INFO - "stage_platform": "linux64-pgo", 16:56:24 INFO - "builduid": "9abe255c289f4eeab38fe4b7321a8100", 16:56:24 INFO - "slavebuilddir": "test" 16:56:24 INFO - } 16:56:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:56:24 INFO - Running post-action listener: _resource_record_post_action 16:56:24 INFO - ##### 16:56:24 INFO - ##### Finished read-buildbot-config step (success) 16:56:24 INFO - ##### 16:56:24 INFO - ##### 16:56:24 INFO - ##### Running download-and-extract step. 16:56:24 INFO - ##### 16:56:24 INFO - Running pre-action listener: _resource_record_pre_action 16:56:24 INFO - Running main action method: download_and_extract 16:56:24 INFO - mkdir: /builds/slave/test/build/tests 16:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:24 INFO - https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:56:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:56:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:56:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:56:27 INFO - Downloaded 1361 bytes. 16:56:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:56:27 INFO - Using the following test package requirements: 16:56:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:56:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:56:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'jsshell-linux-x86_64.zip'], 16:56:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:56:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:56:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:56:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:56:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:56:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:27 INFO - https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:56:30 INFO - Downloaded 24439742 bytes. 16:56:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:56:31 INFO - Return code: 0 16:56:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:56:31 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')]} 16:56:31 INFO - https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:56:38 INFO - Downloaded 24439742 bytes. 16:56:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:56:39 INFO - Return code: 0 16:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:39 INFO - https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:56:40 INFO - Downloaded 10834055 bytes. 16:56:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:56:40 INFO - Return code: 0 16:56:40 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')]} 16:56:40 INFO - https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:56:42 INFO - Downloaded 59046974 bytes. 16:56:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:42 INFO - mkdir: /builds/slave/test/properties 16:56:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:56:42 INFO - Writing to file /builds/slave/test/properties/build_url 16:56:42 INFO - Contents: 16:56:42 INFO - build_url:https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:42 INFO - Running post-action listener: _resource_record_post_action 16:56:42 INFO - Running post-action listener: set_extra_try_arguments 16:56:42 INFO - ##### 16:56:42 INFO - ##### Finished download-and-extract step (success) 16:56:42 INFO - ##### 16:56:42 INFO - ##### 16:56:42 INFO - ##### Running populate-webroot step. 16:56:42 INFO - ##### 16:56:42 INFO - Running pre-action listener: _resource_record_pre_action 16:56:42 INFO - Running main action method: populate_webroot 16:56:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:56:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:56:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:56:42 INFO - '--tppagecycles', 16:56:42 INFO - '7'], 16:56:42 INFO - 'tests': ['tsvgm']}}, 16:56:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:56:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:56:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:56:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:56:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['damp', 'tps']}, 16:56:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'tests': ['damp', 'tps']}, 16:56:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['dromaeo_dom']}, 16:56:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:56:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['a11yr', 16:56:42 INFO - 'ts_paint', 16:56:42 INFO - 'tpaint', 16:56:42 INFO - 'sessionrestore', 16:56:42 INFO - 'sessionrestore_no_auto_restore', 16:56:42 INFO - 'tabpaint']}, 16:56:42 INFO - 'other-e10s': {'tests': ['a11yr', 16:56:42 INFO - 'ts_paint', 16:56:42 INFO - 'tpaint', 16:56:42 INFO - 'sessionrestore', 16:56:42 INFO - 'sessionrestore_no_auto_restore', 16:56:42 INFO - 'tabpaint']}, 16:56:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:56:42 INFO - 'ts_paint', 16:56:42 INFO - 'tpaint', 16:56:42 INFO - 'sessionrestore', 16:56:42 INFO - 'sessionrestore_no_auto_restore', 16:56:42 INFO - 'tabpaint']}, 16:56:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:56:42 INFO - 'ts_paint', 16:56:42 INFO - 'tpaint', 16:56:42 INFO - 'sessionrestore', 16:56:42 INFO - 'sessionrestore_no_auto_restore', 16:56:42 INFO - 'tabpaint']}, 16:56:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['a11yr', 16:56:42 INFO - 'ts_paint', 16:56:42 INFO - 'tpaint', 16:56:42 INFO - 'sessionrestore', 16:56:42 INFO - 'sessionrestore_no_auto_restore', 16:56:42 INFO - 'tabpaint']}, 16:56:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['a11yr', 16:56:42 INFO - 'ts_paint', 16:56:42 INFO - 'tpaint', 16:56:42 INFO - 'sessionrestore', 16:56:42 INFO - 'sessionrestore_no_auto_restore', 16:56:42 INFO - 'tabpaint']}, 16:56:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['tsvgx', 16:56:42 INFO - 'tsvgr_opacity', 16:56:42 INFO - 'tart', 16:56:42 INFO - 'tscrollx', 16:56:42 INFO - 'cart']}, 16:56:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:56:42 INFO - 'tsvgr_opacity', 16:56:42 INFO - 'tart', 16:56:42 INFO - 'tscrollx', 16:56:42 INFO - 'cart']}, 16:56:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'talos_options': ['--disable-e10s'], 16:56:42 INFO - 'tests': ['tp5o']}, 16:56:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'tests': ['tp5o']}, 16:56:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'talos_options': ['--disable-e10s', 16:56:42 INFO - '--xperf_path', 16:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:42 INFO - 'tests': ['tp5n']}, 16:56:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:42 INFO - 'talos_options': ['--xperf_path', 16:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:42 INFO - 'tests': ['tp5n']}}, 16:56:42 INFO - 'talos.zip': {'path': '', 16:56:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:56:42 INFO - Running post-action listener: _resource_record_post_action 16:56:42 INFO - ##### 16:56:42 INFO - ##### Finished populate-webroot step (success) 16:56:42 INFO - ##### 16:56:42 INFO - ##### 16:56:42 INFO - ##### Running create-virtualenv step. 16:56:42 INFO - ##### 16:56:42 INFO - Running pre-action listener: _resource_record_pre_action 16:56:42 INFO - Running main action method: create_virtualenv 16:56:42 INFO - Creating virtualenv /builds/slave/test/build/venv 16:56:42 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 16:56:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:56:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:56:42 INFO - Using real prefix '/usr' 16:56:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:56:43 INFO - Installing distribute.............................................................................................................................................................................................done. 16:56:45 INFO - Installing pip.................done. 16:56:45 INFO - Return code: 0 16:56:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:45 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:56:45 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 16:56:45 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 16:56:45 INFO - Using env: {'DISPLAY': ':0', 16:56:45 INFO - 'HOME': '/home/cltbld', 16:56:45 INFO - 'LANG': 'en_US.UTF-8', 16:56:45 INFO - 'LANGUAGE': 'en_US:en', 16:56:45 INFO - 'LOGNAME': 'cltbld', 16:56:45 INFO - 'MAIL': '/var/mail/cltbld', 16:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:45 INFO - 'MOZ_NO_REMOTE': '1', 16:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:45 INFO - 'NO_EM_RESTART': '1', 16:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:45 INFO - 'PWD': '/builds/slave/test', 16:56:45 INFO - 'SHELL': '/bin/bash', 16:56:45 INFO - 'SHLVL': '1', 16:56:45 INFO - 'TERM': 'linux', 16:56:45 INFO - 'TMOUT': '86400', 16:56:45 INFO - 'USER': 'cltbld', 16:56:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:45 INFO - '_': '/tools/buildbot/bin/python'} 16:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:45 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 16:56:45 INFO - Cleaning up... 16:56:45 INFO - Return code: 0 16:56:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:45 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:56:45 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 16:56:45 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 16:56:45 INFO - Using env: {'DISPLAY': ':0', 16:56:45 INFO - 'HOME': '/home/cltbld', 16:56:45 INFO - 'LANG': 'en_US.UTF-8', 16:56:45 INFO - 'LANGUAGE': 'en_US:en', 16:56:45 INFO - 'LOGNAME': 'cltbld', 16:56:45 INFO - 'MAIL': '/var/mail/cltbld', 16:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:45 INFO - 'MOZ_NO_REMOTE': '1', 16:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:45 INFO - 'NO_EM_RESTART': '1', 16:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:45 INFO - 'PWD': '/builds/slave/test', 16:56:45 INFO - 'SHELL': '/bin/bash', 16:56:45 INFO - 'SHLVL': '1', 16:56:45 INFO - 'TERM': 'linux', 16:56:45 INFO - 'TMOUT': '86400', 16:56:45 INFO - 'USER': 'cltbld', 16:56:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:45 INFO - '_': '/tools/buildbot/bin/python'} 16:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:45 INFO - Downloading/unpacking psutil>=3.1.1 16:56:45 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 16:56:45 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 16:56:45 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 16:56:45 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 16:56:45 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 16:56:45 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 16:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:47 INFO - Installing collected packages: psutil 16:56:47 INFO - Running setup.py install for psutil 16:56:47 INFO - building 'psutil._psutil_linux' extension 16:56:47 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 16:56:48 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 16:56:48 INFO - building 'psutil._psutil_posix' extension 16:56:48 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 16:56:48 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 16:56:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:48 INFO - Successfully installed psutil 16:56:48 INFO - Cleaning up... 16:56:48 INFO - Return code: 0 16:56:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:56:48 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')]} 16:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:48 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')]} 16:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:48 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:56:48 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 16:56:48 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 16:56:48 INFO - Using env: {'DISPLAY': ':0', 16:56:48 INFO - 'HOME': '/home/cltbld', 16:56:48 INFO - 'LANG': 'en_US.UTF-8', 16:56:48 INFO - 'LANGUAGE': 'en_US:en', 16:56:48 INFO - 'LOGNAME': 'cltbld', 16:56:48 INFO - 'MAIL': '/var/mail/cltbld', 16:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:48 INFO - 'MOZ_NO_REMOTE': '1', 16:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:48 INFO - 'NO_EM_RESTART': '1', 16:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:48 INFO - 'PWD': '/builds/slave/test', 16:56:48 INFO - 'SHELL': '/bin/bash', 16:56:48 INFO - 'SHLVL': '1', 16:56:48 INFO - 'TERM': 'linux', 16:56:48 INFO - 'TMOUT': '86400', 16:56:48 INFO - 'USER': 'cltbld', 16:56:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:48 INFO - '_': '/tools/buildbot/bin/python'} 16:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:56:50 INFO - Installing collected packages: mozsystemmonitor 16:56:50 INFO - Running setup.py install for mozsystemmonitor 16:56:50 INFO - Successfully installed mozsystemmonitor 16:56:50 INFO - Cleaning up... 16:56:50 INFO - Return code: 0 16:56:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:56:50 INFO - Using env: {'DISPLAY': ':0', 16:56:50 INFO - 'HOME': '/home/cltbld', 16:56:50 INFO - 'LANG': 'en_US.UTF-8', 16:56:50 INFO - 'LANGUAGE': 'en_US:en', 16:56:50 INFO - 'LOGNAME': 'cltbld', 16:56:50 INFO - 'MAIL': '/var/mail/cltbld', 16:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:50 INFO - 'MOZ_NO_REMOTE': '1', 16:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:50 INFO - 'NO_EM_RESTART': '1', 16:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:50 INFO - 'PWD': '/builds/slave/test', 16:56:50 INFO - 'SHELL': '/bin/bash', 16:56:50 INFO - 'SHLVL': '1', 16:56:50 INFO - 'TERM': 'linux', 16:56:50 INFO - 'TMOUT': '86400', 16:56:50 INFO - 'USER': 'cltbld', 16:56:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:50 INFO - '_': '/tools/buildbot/bin/python'} 16:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:56:50 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 16:56:50 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 16:56:50 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 16:56:50 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 16:56:50 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 16:56:50 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 16:56:52 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:56:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:53 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 16:56:53 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 16:56:53 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 16:56:53 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 16:56:53 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 16:56:53 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 16:56:53 INFO - Downloading docopt-0.6.1.tar.gz 16:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:53 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:53 INFO - Running setup.py install for blobuploader 16:56:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:56:53 INFO - Running setup.py install for requests 16:56:53 INFO - Running setup.py install for docopt 16:56:54 INFO - Successfully installed blobuploader requests docopt 16:56:54 INFO - Cleaning up... 16:56:54 INFO - Return code: 0 16:56:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:54 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')]} 16:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:54 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')]} 16:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:54 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:56:54 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 16:56:54 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 16:56:54 INFO - Using env: {'DISPLAY': ':0', 16:56:54 INFO - 'HOME': '/home/cltbld', 16:56:54 INFO - 'LANG': 'en_US.UTF-8', 16:56:54 INFO - 'LANGUAGE': 'en_US:en', 16:56:54 INFO - 'LOGNAME': 'cltbld', 16:56:54 INFO - 'MAIL': '/var/mail/cltbld', 16:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:54 INFO - 'MOZ_NO_REMOTE': '1', 16:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:54 INFO - 'NO_EM_RESTART': '1', 16:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:54 INFO - 'PWD': '/builds/slave/test', 16:56:54 INFO - 'SHELL': '/bin/bash', 16:56:54 INFO - 'SHLVL': '1', 16:56:54 INFO - 'TERM': 'linux', 16:56:54 INFO - 'TMOUT': '86400', 16:56:54 INFO - 'USER': 'cltbld', 16:56:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:54 INFO - '_': '/tools/buildbot/bin/python'} 16:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:54 INFO - Running setup.py (path:/tmp/pip-KjIkHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:54 INFO - Running setup.py (path:/tmp/pip-weDWDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:54 INFO - Running setup.py (path:/tmp/pip-qYzqA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:54 INFO - Running setup.py (path:/tmp/pip-F_GDXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:54 INFO - Running setup.py (path:/tmp/pip-wAfgDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:54 INFO - Running setup.py (path:/tmp/pip-Ui9B8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:54 INFO - Running setup.py (path:/tmp/pip-v_vvyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:54 INFO - Running setup.py (path:/tmp/pip-CQuocR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:54 INFO - Running setup.py (path:/tmp/pip-cq_djK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:54 INFO - Running setup.py (path:/tmp/pip-EP7zq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:55 INFO - Running setup.py (path:/tmp/pip-eIhMBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:55 INFO - Running setup.py (path:/tmp/pip-yNCkbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:55 INFO - Running setup.py (path:/tmp/pip-eWXwqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:55 INFO - Running setup.py (path:/tmp/pip-8Mp24S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:55 INFO - Running setup.py (path:/tmp/pip-4iEyqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:55 INFO - Running setup.py (path:/tmp/pip-zdUoWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:55 INFO - Running setup.py (path:/tmp/pip-2kDSyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:55 INFO - Running setup.py install for manifestparser 16:56:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:55 INFO - Running setup.py install for mozcrash 16:56:55 INFO - Running setup.py install for mozdebug 16:56:55 INFO - Running setup.py install for mozdevice 16:56:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:56:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:55 INFO - Running setup.py install for mozfile 16:56:56 INFO - Running setup.py install for mozhttpd 16:56:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Running setup.py install for mozinfo 16:56:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Running setup.py install for mozInstall 16:56:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Running setup.py install for mozleak 16:56:56 INFO - Running setup.py install for mozlog 16:56:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Running setup.py install for moznetwork 16:56:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Running setup.py install for mozprocess 16:56:56 INFO - Running setup.py install for mozprofile 16:56:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Running setup.py install for mozrunner 16:56:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:56 INFO - Running setup.py install for mozscreenshot 16:56:57 INFO - Running setup.py install for moztest 16:56:57 INFO - Running setup.py install for mozversion 16:56:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:57 INFO - Cleaning up... 16:56:57 INFO - Return code: 0 16:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:57 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:56:57 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 16:56:57 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 16:56:57 INFO - Using env: {'DISPLAY': ':0', 16:56:57 INFO - 'HOME': '/home/cltbld', 16:56:57 INFO - 'LANG': 'en_US.UTF-8', 16:56:57 INFO - 'LANGUAGE': 'en_US:en', 16:56:57 INFO - 'LOGNAME': 'cltbld', 16:56:57 INFO - 'MAIL': '/var/mail/cltbld', 16:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:57 INFO - 'MOZ_NO_REMOTE': '1', 16:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:57 INFO - 'NO_EM_RESTART': '1', 16:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:57 INFO - 'PWD': '/builds/slave/test', 16:56:57 INFO - 'SHELL': '/bin/bash', 16:56:57 INFO - 'SHLVL': '1', 16:56:57 INFO - 'TERM': 'linux', 16:56:57 INFO - 'TMOUT': '86400', 16:56:57 INFO - 'USER': 'cltbld', 16:56:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:57 INFO - '_': '/tools/buildbot/bin/python'} 16:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:57 INFO - Running setup.py (path:/tmp/pip-MNBLsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:57 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)) 16:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:57 INFO - Running setup.py (path:/tmp/pip-qnuGQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:57 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)) 16:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:57 INFO - Running setup.py (path:/tmp/pip-vFPni9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:57 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)) 16:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:57 INFO - Running setup.py (path:/tmp/pip-EmZwvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:57 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)) 16:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:57 INFO - Running setup.py (path:/tmp/pip-9AehPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:57 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)) 16:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:57 INFO - Running setup.py (path:/tmp/pip-9WFGRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:57 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)) 16:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:57 INFO - Running setup.py (path:/tmp/pip-lDko3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:58 INFO - Running setup.py (path:/tmp/pip-DpDMpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:58 INFO - Running setup.py (path:/tmp/pip-ZfkJNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:58 INFO - Running setup.py (path:/tmp/pip-v50Gl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:58 INFO - Running setup.py (path:/tmp/pip-ClPgwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:58 INFO - Running setup.py (path:/tmp/pip-dHK2Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:58 INFO - Running setup.py (path:/tmp/pip-WUdCV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:58 INFO - Running setup.py (path:/tmp/pip-dNagmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:58 INFO - Running setup.py (path:/tmp/pip-_f33XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:58 INFO - Running setup.py (path:/tmp/pip-bqu8ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:58 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)) 16:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:58 INFO - Running setup.py (path:/tmp/pip-ym0R9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:58 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)) 16:56:58 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)) 16:56:58 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)) 16:56:58 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)) 16:56:58 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)) 16:56:58 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)) 16:56:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:58 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 16:56:58 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 16:56:58 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 16:56:58 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 16:56:58 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 16:56:58 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 16:57:00 INFO - Downloading blessings-1.6.tar.gz 16:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:00 INFO - Installing collected packages: blessings 16:57:00 INFO - Running setup.py install for blessings 16:57:00 INFO - Successfully installed blessings 16:57:00 INFO - Cleaning up... 16:57:00 INFO - Return code: 0 16:57:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:57:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:01 INFO - Reading from file tmpfile_stdout 16:57:01 INFO - Current package versions: 16:57:01 INFO - argparse == 1.2.1 16:57:01 INFO - blessings == 1.6 16:57:01 INFO - blobuploader == 1.2.4 16:57:01 INFO - docopt == 0.6.1 16:57:01 INFO - manifestparser == 1.1 16:57:01 INFO - mozInstall == 1.12 16:57:01 INFO - mozcrash == 0.17 16:57:01 INFO - mozdebug == 0.1 16:57:01 INFO - mozdevice == 0.48 16:57:01 INFO - mozfile == 1.2 16:57:01 INFO - mozhttpd == 0.7 16:57:01 INFO - mozinfo == 0.9 16:57:01 INFO - mozleak == 0.1 16:57:01 INFO - mozlog == 3.2 16:57:01 INFO - moznetwork == 0.27 16:57:01 INFO - mozprocess == 0.22 16:57:01 INFO - mozprofile == 0.28 16:57:01 INFO - mozrunner == 6.11 16:57:01 INFO - mozscreenshot == 0.1 16:57:01 INFO - mozsystemmonitor == 0.3 16:57:01 INFO - moztest == 0.7 16:57:01 INFO - mozversion == 1.4 16:57:01 INFO - psutil == 3.1.1 16:57:01 INFO - requests == 1.2.3 16:57:01 INFO - wsgiref == 0.1.2 16:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:01 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:57:01 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 16:57:01 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 16:57:01 INFO - Using env: {'DISPLAY': ':0', 16:57:01 INFO - 'HOME': '/home/cltbld', 16:57:01 INFO - 'LANG': 'en_US.UTF-8', 16:57:01 INFO - 'LANGUAGE': 'en_US:en', 16:57:01 INFO - 'LOGNAME': 'cltbld', 16:57:01 INFO - 'MAIL': '/var/mail/cltbld', 16:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:01 INFO - 'MOZ_NO_REMOTE': '1', 16:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:01 INFO - 'NO_EM_RESTART': '1', 16:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:01 INFO - 'PWD': '/builds/slave/test', 16:57:01 INFO - 'SHELL': '/bin/bash', 16:57:01 INFO - 'SHLVL': '1', 16:57:01 INFO - 'TERM': 'linux', 16:57:01 INFO - 'TMOUT': '86400', 16:57:01 INFO - 'USER': 'cltbld', 16:57:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:01 INFO - '_': '/tools/buildbot/bin/python'} 16:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 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)) 16:57:01 INFO - Cleaning up... 16:57:01 INFO - Return code: 0 16:57:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:01 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:57:01 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 16:57:01 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 16:57:01 INFO - Using env: {'DISPLAY': ':0', 16:57:01 INFO - 'HOME': '/home/cltbld', 16:57:01 INFO - 'LANG': 'en_US.UTF-8', 16:57:01 INFO - 'LANGUAGE': 'en_US:en', 16:57:01 INFO - 'LOGNAME': 'cltbld', 16:57:01 INFO - 'MAIL': '/var/mail/cltbld', 16:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:01 INFO - 'MOZ_NO_REMOTE': '1', 16:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:01 INFO - 'NO_EM_RESTART': '1', 16:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:01 INFO - 'PWD': '/builds/slave/test', 16:57:01 INFO - 'SHELL': '/bin/bash', 16:57:01 INFO - 'SHLVL': '1', 16:57:01 INFO - 'TERM': 'linux', 16:57:01 INFO - 'TMOUT': '86400', 16:57:01 INFO - 'USER': 'cltbld', 16:57:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:01 INFO - '_': '/tools/buildbot/bin/python'} 16:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:01 INFO - Downloading/unpacking jsonschema 16:57:01 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 16:57:01 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 16:57:01 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 16:57:01 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 16:57:01 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 16:57:01 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 16:57:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:03 INFO - Downloading/unpacking functools32 (from jsonschema) 16:57:03 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 16:57:03 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 16:57:03 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 16:57:03 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 16:57:03 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 16:57:03 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 16:57:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:03 INFO - warning: no files found matching '*.txt' 16:57:03 INFO - no previously-included directories found matching 'build' 16:57:03 INFO - no previously-included directories found matching 'dist' 16:57:03 INFO - no previously-included directories found matching '.git*' 16:57:03 INFO - Installing collected packages: jsonschema, functools32 16:57:03 INFO - Running setup.py install for functools32 16:57:03 INFO - warning: no files found matching '*.txt' 16:57:03 INFO - no previously-included directories found matching 'build' 16:57:03 INFO - no previously-included directories found matching 'dist' 16:57:03 INFO - no previously-included directories found matching '.git*' 16:57:03 INFO - Successfully installed jsonschema functools32 16:57:03 INFO - Cleaning up... 16:57:03 INFO - Return code: 0 16:57:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:03 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 0x7f2e3d36bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, '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': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', '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 16:57:03 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 16:57:03 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 16:57:03 INFO - Using env: {'DISPLAY': ':0', 16:57:03 INFO - 'HOME': '/home/cltbld', 16:57:03 INFO - 'LANG': 'en_US.UTF-8', 16:57:03 INFO - 'LANGUAGE': 'en_US:en', 16:57:03 INFO - 'LOGNAME': 'cltbld', 16:57:03 INFO - 'MAIL': '/var/mail/cltbld', 16:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:03 INFO - 'MOZ_NO_REMOTE': '1', 16:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:03 INFO - 'NO_EM_RESTART': '1', 16:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:03 INFO - 'PWD': '/builds/slave/test', 16:57:03 INFO - 'SHELL': '/bin/bash', 16:57:03 INFO - 'SHLVL': '1', 16:57:03 INFO - 'TERM': 'linux', 16:57:03 INFO - 'TMOUT': '86400', 16:57:03 INFO - 'USER': 'cltbld', 16:57:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:03 INFO - '_': '/tools/buildbot/bin/python'} 16:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:04 INFO - Downloading/unpacking flake8 16:57:04 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 16:57:04 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 16:57:04 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 16:57:04 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 16:57:04 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 16:57:04 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 16:57:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:57:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:57:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:57:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:57:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:57:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:57:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:57:06 INFO - no previously-included directories found matching 'docs/_build' 16:57:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:57:06 INFO - Running setup.py install for pep8 16:57:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:57:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:57:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:57:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:57:06 INFO - no previously-included directories found matching 'docs/_build' 16:57:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:57:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:57:06 INFO - Cleaning up... 16:57:06 INFO - Return code: 0 16:57:06 INFO - Running post-action listener: _resource_record_post_action 16:57:06 INFO - Running post-action listener: _start_resource_monitoring 16:57:06 INFO - Starting resource monitoring. 16:57:06 INFO - ##### 16:57:06 INFO - ##### Finished create-virtualenv step (success) 16:57:06 INFO - ##### 16:57:06 INFO - ##### 16:57:06 INFO - ##### Running install step. 16:57:06 INFO - ##### 16:57:06 INFO - Running pre-action listener: _resource_record_pre_action 16:57:06 INFO - Running main action method: install 16:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:07 INFO - Reading from file tmpfile_stdout 16:57:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:57:07 INFO - Reading from file tmpfile_stdout 16:57:07 INFO - Output received: 16:57:07 INFO - Usage: mozinstall [options] installer 16:57:07 INFO - Options: 16:57:07 INFO - -h, --help show this help message and exit 16:57:07 INFO - -d DEST, --destination=DEST 16:57:07 INFO - Directory to install application into. [default: 16:57:07 INFO - "/builds/slave/test"] 16:57:07 INFO - --app=APP Application being installed. [default: firefox] 16:57:07 INFO - mkdir: /builds/slave/test/build/application 16:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:57:24 INFO - Reading from file tmpfile_stdout 16:57:24 INFO - Output received: 16:57:24 INFO - /builds/slave/test/build/application/firefox/firefox 16:57:24 INFO - Running post-action listener: _resource_record_post_action 16:57:24 INFO - ##### 16:57:24 INFO - ##### Finished install step (success) 16:57:24 INFO - ##### 16:57:24 INFO - ##### 16:57:24 INFO - ##### Running run-tests step. 16:57:24 INFO - ##### 16:57:24 INFO - Running pre-action listener: _resource_record_pre_action 16:57:24 INFO - Running main action method: run_tests 16:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:57:24 INFO - Python 2.7.3 16:57:24 INFO - Return code: 0 16:57:24 INFO - grabbing minidump binary from tooltool 16:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:24 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 0x2c7a9c0>, '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 0x2c7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:57:24 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 16:57:24 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 16:57:24 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 16:57:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:57:24 INFO - Return code: 0 16:57:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:57:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:57:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:57:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:57:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:57:25 INFO - Return code: 0 16:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 16:57:25 INFO - Using env: {'DISPLAY': ':0', 16:57:25 INFO - 'HOME': '/home/cltbld', 16:57:25 INFO - 'LANG': 'en_US.UTF-8', 16:57:25 INFO - 'LANGUAGE': 'en_US:en', 16:57:25 INFO - 'LOGNAME': 'cltbld', 16:57:25 INFO - 'MAIL': '/var/mail/cltbld', 16:57:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:57:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:25 INFO - 'MOZ_NO_REMOTE': '1', 16:57:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:25 INFO - 'NO_EM_RESTART': '1', 16:57:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:25 INFO - 'PWD': '/builds/slave/test', 16:57:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:57:25 INFO - 'SHELL': '/bin/bash', 16:57:25 INFO - 'SHLVL': '1', 16:57:25 INFO - 'TERM': 'linux', 16:57:25 INFO - 'TMOUT': '86400', 16:57:25 INFO - 'USER': 'cltbld', 16:57:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108', 16:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:25 INFO - '_': '/tools/buildbot/bin/python'} 16:57:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:57:25 INFO - mozversion application_buildid: 20160602143006 16:57:25 INFO - mozversion application_changeset: f76a0fdadbf053c3373961f9afbc966c011a50fe 16:57:25 INFO - mozversion application_display_name: Nightly 16:57:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:57:25 INFO - mozversion application_name: Firefox 16:57:25 INFO - mozversion application_remotingname: firefox 16:57:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:57:25 INFO - mozversion application_vendor: Mozilla 16:57:25 INFO - mozversion application_version: 49.0a1 16:57:25 INFO - mozversion platform_buildid: 20160602143006 16:57:25 INFO - mozversion platform_changeset: f76a0fdadbf053c3373961f9afbc966c011a50fe 16:57:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:57:25 INFO - mozversion platform_version: 49.0a1 16:57:25 INFO - using testdate: 1464911845 16:57:25 INFO - actual date: 1464911845 16:57:25 INFO - starting webserver on 'localhost:56352' 16:57:25 INFO - SUITE-START | Running 2 tests 16:57:25 INFO - TEST-START | dromaeo_css 16:57:25 INFO - operating with platform_type : linux_ 16:57:25 INFO - Initialising browser for dromaeo_css test... 16:57:25 INFO - TEST-INFO | started process 4354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAYGj4d/profile http://localhost:56352/getInfo.html) 16:57:29 INFO - PROCESS | 4354 | __metrics Screen width/height:1600/1200 16:57:29 INFO - PROCESS | 4354 | colorDepth:24 16:57:29 INFO - PROCESS | 4354 | Browser inner width/height: 1024/697 16:57:29 INFO - PROCESS | 4354 | __metrics 16:57:30 ERROR - PROCESS | 4354 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 16:57:31 INFO - TEST-INFO | 4354: exit 0 16:57:31 INFO - Browser initialized. 16:57:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:57:31 INFO - TEST-INFO | started process 4474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAYGj4d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:43 INFO - PROCESS | 4474 | RSS: Main: 167403520 16:57:43 INFO - PROCESS | 4474 | 16:58:32 INFO - PROCESS | 4474 | 1464911912927 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] 17:00:39 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:56352/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56352/tests/dromaeo/cssquery-ext.html) 17:00:40 INFO - PROCESS | 4474 | RSS: Main: 170573824 17:00:40 INFO - PROCESS | 4474 | 17:03:42 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:56352/tests/dromaeo/cssquery-ext.html (next: http://localhost:56352/tests/dromaeo/cssquery-jquery.html) 17:03:43 INFO - PROCESS | 4474 | RSS: Main: 169975808 17:03:43 INFO - PROCESS | 4474 | 17:06:45 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:56352/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56352/tests/dromaeo/cssquery-mootools.html) 17:06:45 INFO - PROCESS | 4474 | RSS: Main: 171118592 17:06:45 INFO - PROCESS | 4474 | 17:09:47 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:56352/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56352/tests/dromaeo/cssquery-prototype.html) 17:09:48 INFO - PROCESS | 4474 | RSS: Main: 168820736 17:09:48 INFO - PROCESS | 4474 | 17:12:50 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:56352/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56352/tests/dromaeo/cssquery-yui.html) 17:12:51 INFO - PROCESS | 4474 | RSS: Main: 171118592 17:12:51 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | Cycle 1(1): loaded http://localhost:56352/tests/dromaeo/cssquery-yui.html (next: http://localhost:56352/tests/dromaeo/cssquery-dojo.html) 17:15:53 INFO - PROCESS | 4474 | RSS: Main: 172118016 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | __start_tp_report 17:15:53 INFO - PROCESS | 4474 | _x_x_mozilla_page_load 17:15:53 INFO - PROCESS | 4474 | _x_x_mozilla_page_load_details 17:15:53 INFO - PROCESS | 4474 | |i|pagename|runs| 17:15:53 INFO - PROCESS | 4474 | |0;dojo.html;3067.386522695461;3104.5032794752815;3125.5155450905104;3130.076627394919;3141.607299087614;5264.973675131624;5289.312389389374;5338.599605029619;5377.838664840051;5398.406175320712;5271.051210782058;5292.153255479124;5328.49379308966;5429.945700542993;5433.049216387127;4906.1168989581865;4924.729139897304;5004;5045.924311135336;5092.898142037157;523.8876110778615;4801.447833499157;4862.367892174012;4862.927056094161;4955.975220123894;4742.454617718972;4822.4936381679945;4826.9034619307595;4840.104580652591;4892.2661600760175;4825.445073816521;4846.273059041137;4846.854594362175;4866.829660961849;4905.656604037718;4826.710397376169;4847.079054979543;4877.487863774288;4897.4857639948;4946.9010619787405;5238.633295669305;5258.92111618326;5293.682379057231;5299.417064122943;5319.654222475527;5643.520300774439;5754.88490230193;5790.652560846363;5807.535397168216;5809.419058094157;5724.2558467399385;5756.884862302731;5812.680302583356;5819.388964158745;5839.678817665027;5438.374586922476;5440.3743569489225;5441.972790136024;5447.1829225616075;5457.181422786574;5779.33537643168;5913.645181289136;5972.223610930551;6010.038393856962;6019.729112189962;5717.542596592262;5792.652440853562;5797.449242321973;5798.072308430631;5847.152162936351;5844.094165404369;5874.324452687995;5881.3530511643685;5882.323532793698;5898.026825573732;5618.213450116987;5641.774329026875;5659.490645841812;5810.360860305363;5829.766809327664;5693.886122277531;5708.543316534668;5718.056520674042;5718.857028574235;5762.164486149485;4357.302831547001;4382.211201983673;4383.736975781463;4398.73607583546;4411.625011874026;3837.175007373428;3901.902452438655;3924.47019652349;3973.443717879499;3992.161646054361;5306.814261500829;5325.227841962894;5330.360356757214;5342.626016178908;5355.839324820262;5661.886762264731;5712.885742285131;5729.541636669056;5737.540996720252;5761.85595360111;5297.788088476418;5313.203019547099;5355.062863998784;5404.108322126884;5426.782928682887;4932.90134197314;4975.179095449211;4978.079055374767;4986.675866068694;5038.294638750578;5966.731497082642;5993.910091348634;5994.880102397928;6001.12983617373;6001.939980600138;5566.749496272678;5714.371419143974;5744.167095771173;5783.826485205451;5785.27684039495;5937.7921772737745;5962.821115366546;6012.248468941382;6013.579049466495;6040.09398590215;5554.694491802989;5714.79998200061;5721.485066344049;5731.656100633975;5733.197352370588;5695.686737229492;5700.25896633435;5764.481196692318;5774.48029677331;5788.652680839163;5604.579656525695;5624.7187640616985;5637.88724225505;5641.746121424628;5647.632903861236;5422.132458806572;5576.10782274834;5582.051051321204;5611.410801865745;5627.774889004394;5367.087595108763;5378.085725426765;5400.783968641367;5417.160340147283;5467.234587157722;5499.7250137492165;5502.697351645698;5521.171824226238;5536.7819079802375;5570.220169176399;5391.892162156813;5450.563954883521;5495.626093476631;5496.917546236889;5498 17:15:53 INFO - PROCESS | 4474 | |1;ext.html;582.2634367525081;627.8493161641205;632.5319263744827;645.8901986662266;659.1003280522089;38811;42946;43067;43219.78390108053;43266.783666081705;43923.34114988278;44361;44406.11187776243;44439.33340999888;44449.55550444494;8513.148685131498;8618;8625.698100566482;8639.265662418702;8651.221390074892;8539;8542.615582298811;8598.87101693475;8603.48379097253;8640.611172497222;8587.227149556538;8597.914020859806;8671.306295496344;8682.609282582267;8707.390482666184;8554.657813687445;8650.394472386935;8658.783530411758;8665.09016553259;8670.393072484929;8722.738317850475;8812.339074569432;8817.074207208216;8834.07242239562;8837.823243535158;39488.21023579541;39940.20119597592;39951.20097598061;40004.19991600181;40004.19991600181;2842.2610121368384;3120.204347891296;3283.9014829555153;3348.68187522185;3446.638102999199;29735.107946761633;29822.70177298221;30342;30351.848240758656;30428;3941;3956.5054368203973;3962.0491082140366;4081.89795255121;4134.772587507686;304120;304279.9999999978;304613;304734;305140;34304;34509.13727156841;34609.826950865085;34648;35320.64679353225;36430.63569364326;36511.269774604356;36587.63412365896;36718.632813672055;36740.44889326662;14043.578692639237;14185.219812910389;14186.077904936146;14186.219757913208;14226.715465690628;11701.2979221247;11817.704557386134;11867.525298988117;11891.702707432383;11925.34410607425;8341.416100873003;8355.916440835636;8404.831903362021;8422.199891010345;8482.872756908651;3221.597300337458;3299.785513941586;3318.2368055346924;3319.9502007469905;3349.69852713257;979.5836769372988;981.3572110267786;1040.0447159340392;1119.7200699825044;1126.2003977176132;30177.437896736406;30441.39117217643;30722;31037.68962310393;31583.21041973969;1076.0423223331086;1103.27184058521;1121;1213.096243298748;1214.2532342609231;16520.917395413187;16687.91656041736;16775.832241677672;16843.592371135994;16900.915495422443;566099;569480;572524;573653;574878;57741.2969146787;58164.41835581675;58447;58629.706851466326;58641.70679146577;1312.934353282332;1383.087162472763;1391.325207274471;1393.4913756478811;1395.7208558288382;30111.397772044875;30873;31072.533911990886;31206;31727.682723173395;49714.254286185016;50188.498115019844;50364;50364.24453633272;50431.747841260556;368143;369287;369461;370908;371013;27702.722972770014;27704.445911082068;28881.855590721912;28935.276618084717;29956.400871982;48923.755381222865;48990.26514602355;49284.2607360897;49823.25265121098;49835.25247121223;40350.1929961405;40697.59302406938;40854.79572602118;41028.79485602553;41871;39688.71206365648;40788.79605601953;41035.576256070715;41136.79431602823;41553.58446415497;39844.40233396559;40596.3910541348;40815;40931;41094.58905410908;35778.463323049655;36913;37058.14709264472;37102.44346334753;37653.435198471496;28102.437951240452;28349.1634542784;28377.787059689912;28395.320935812506;28502.28986260831 17:15:53 INFO - PROCESS | 4474 | |2;jquery.html;390.7831153709692;394.5265681182582;397.9502562179726;402.67182246469133;417.90388210711535;13940.93029534851;17824.10879456027;19239.61520769584;19377.806221937793;19726.40820775379;18249.36127235547;18342;18572.07139643019;19485.123169457373;19538.218471261167;5484.862878428041;5574.163875418679;5608.831735047935;5650.29371328584;5826.679532625704;5708.600397972144;5711.314642242916;5750.05124154514;5783.277090363705;5788.6237394569425;5267.894642107156;5541.722913854312;5564.86087847803;5661.320641523002;5743.942560574383;5508.6970216638065;5588.580856435763;5593.105103183491;5632.943670563303;5944;5727.255456790591;5756.971215143939;5767.250257466544;5775.537956963432;5799.9130013049835;13402.664933376744;16233.83766162335;20693.241074508685;22200.444988875246;22306.107755689754;2276.362618466832;2323.7095363079616;2374.4776149247136;2490.2902672738182;2497.250824752567;9935.304528682995;10190.694279171637;10245.48772561369;10250.58997640101;10525.36847789135;1926.6724656808376;1940.9708854367195;1960.1081507913866;1973.9703904441444;2013.496625843539;80143.59928200321;81499.5925020377;82886.58556707177;83791.5810420944;83887;10481.947590262153;10889.062000639195;10951.83572246417;11059.557617695364;11154.60958866452;15242.3903043877;15369.923150384177;15435.228238588026;15462.768058479132;15478.5356439307;7485.663145158481;7511.136219334737;7591.772246832494;7613.42899282556;7640.73257435987;7066.340538112054;7068.469864760164;7097.21930587635;7158.92616107588;7183.06620139389;4359.14996575671;4376.868693939124;4427.977860110744;4437.356583295404;4512.864614061584;1918.194358369488;1965.2335589120255;1969.0745349685624;1999.7000449932627;2004.0981558298824;920.9493477858782;983.0317137619439;999.4552968632113;1027.5684212630713;1045.6862941117633;18618.906905465385;18864.622707545772;19320.4203873884;19472.123754431086;19706.408807735792;989.9505024748734;1019.4291196929743;1046.581367453025;1080.4975686305747;1086.820674588684;9340.34617576763;10778.568857245622;10870.402127883042;10900.890991090146;10920.836187457195;472275;472796;488978.76744174166;498712;499522;85711;87212;88344.5582772082;88415.55792220998;88765.11234887698;995.0397866059287;996.272720913737;1008.3445760255746;1024.779672370444;1034.4879284754095;16817.831821681626;17048.31806727717;17231.138443078045;17236.741448878027;17429.912850435667;39873.401898972115;40024;40405;41065.384019239136;41304.38043429291;55104.17343739927;56118;56974.43025569857;57638.423615763306;57882.710586446796;8571.528565928933;8600.526971016403;8610.354223433393;8753.387262891536;8930.86603700932;9800.705978820646;12842.743145136857;12919.547815826401;13078.149920255153;13418.127821691558;11574.942125289319;11642.417879105842;11785.764284714429;11799.233049851731;12005.519779209084;11363.204575679623;11412.771744565229;11486.483108259981;11567;11628.767424651629;11635.185537012328;11650.359230242419;11925.522979081086;11986.580469683518;12177.817332740193;7202.243764404871;7476.289752473506;7897.328727058264;8623.956880215559;8714.433561818461;8756.737297881074;11626.651200463999;11871.347075910908;11913.642590722293;12033.278003319829 17:15:53 INFO - PROCESS | 4474 | |3;mootools.html;1475.085447022846;1501.8347981722009;1633.8447847454495;1750.571110078031;1769.7699299091125;7183.82040448989;8006.119326874046;8083.43415960883;8473.830523389528;8544.401891867572;8100.51396916184;8315.584220788967;8352.081271060179;8408.285295749853;8448.23965843074;2241.506868488934;2263.207877242968;2270.9318720438414;2272.1820144747876;2272.2728726807427;2251.324602619216;2251.6735073414425;2292.5758734634064;2293.0713061210154;2294.265834932822;2236.1614394602025;2242.7532971373216;2253.9774602254015;2268.1494439585153;2296.2651951375565;2201.966970495444;2226.532428190074;2230.944226394337;2234.061694088479;2237.8209743220505;2298.1841446286494;2314.3751187179537;2319.8376113672048;2326.732425771041;2329.5457385809773;8472.322214222848;8526.403151779377;8531.01893282268;8534.658613655447;8548.230659240699;4861.295112208745;4927.6550641455115;4952.579030782388;4955.331030310898;4968.90062198754;2853.9714602853915;2934.3691106412225;3011.623547056618;3054.205906464313;3054.404391143728;997.1922742578535;1043.128987295609;1048.6958781953224;1080.5785743560018;1086.0334302470808;11201.831972520418;11217;11221.326720396803;11232.55069797199;11256.437178141143;4169.478815148106;4364.738115713068;4383.189110014658;4385.890352741207;4395.670324725595;9541.47521886303;9586.089321514444;9592.08875156859;9617.461206206974;9627;4936.037472692862;4957;4959.256111583291;4972.825951091694;5002.049610573979;4161.895952601149;4632.837850675278;4639.327297541905;4693.812247510062;4709.458412282632;3898.161895192547;3908.882733517999;3954.4463775071513;3979.164375481181;4048;1248.5318005747845;1289.5035411366691;1290.5676598339473;1294.3592921503728;1296.6563860576955;981.3375971219398;1004.2769206171545;1013.5185786751234;1015.5531566110888;1021.8416145497459;5933.317668468181;5983.521318294526;5989.1914591529585;6043.153958445821;6176.8764624707255;446.8525386622407;448.91470620581987;451.41090876406605;452.17252428057236;459.28122488305695;4246.363045543193;4246.787660616957;4250.851220207278;4259.403683484315;4284.314509678499;10298.279120461646;10585.576576936835;10624.468776561142;10667.946660266649;10684.412357320267;10403.94798026005;10487.318324308895;10505.579776808994;10515;10563.63027294041;7621.275978782118;7948.6820527179425;7970.960145199237;8070.83858322842;8107.391945604103;5856.824295271149;5898.764049437975;5930.406959304035;5983.1025346196675;6002.309734380602;9543.42739435636;9791.706248812547;10035.598576056876;10053.748656283358;10055.296129271173;9859.507024648596;10025.649102281384;10164.695059148238;10232.232582556488;10292.742681433025;6707.765228216989;6956.826079347854;6991.895121573282;7272.854542909218;7565.773026809205;8271.627776750182;8284.958575207085;8288;8299.917000829915;8357.08072112055;7250;7303.561786292839;7528.811779705551;7621.923780762343;7694.538327700356;7213.9278607213255;7236.565806051653;7348.448866334939;7431.925680743123;7611.048618922635;6769.323067693192;6826.044353790573;6849.452043836581;6850.657467126524;6858.6570671467225;5099.133147365031;5176.637635365489;5204.401493828107;5306.177542480922;5403.9459605403445;5152.4847515248175;5157.045946499909;5186.6369354144845;5237.659552129099;5250.238715386324 17:15:53 INFO - PROCESS | 4474 | |4;prototype.html;332.19111463586165;334.3663757180143;334.9296647703982;336.5002970588674;344.43512639271586;5536.307961504812;5600.887982240352;5628.268325117734;5675.659460432377;5677.545796336293;5538.695371754552;5545.528630066449;5563.554915606752;5573.749181286842;5587.580931430139;4178.310578754509;4208.936865947013;4376.059147283333;4387.692861499696;4398.516163222043;4354;4354.368616550598;4409.713368631044;4415.8233670653135;4428.136513379892;4368.847090351823;4372.978135109336;4374;4381.474223093217;4400.921774165318;4238.770756480632;4323.113761678864;4325.199838029975;4326.6754993375625;4347.913041739147;3774.452704357853;3804.7907365094907;3813.2182902505197;3824.541055073409;3840.7695538267512;5371.060064488699;5374.193870919355;5375;5378.946210537883;5445.1832225166545;4849.951500484985;4910.337104490884;4924.630652701062;4936.80252789888;4955.653104282702;5725.740337125826;5750.568707346965;5778.855528611776;5780.8843823123725;5809.970950145223;4249.87250382489;4257.87226383209;4268.466441694788;4272.931767058236;4277.144571085764;5825.359210486843;6049.546284028672;6066.150738896602;6125.418085281891;6153.630922045353;4211.936820947688;4218.6414154797185;4239.957600424018;4255.616994470451;4259.297215959332;4276.337167739005;4301.376300436419;4308.849190278325;4310.4611923509565;4332.610065094157;4715.81136754526;4832.299316599074;4877.170880950247;4886.193778026586;4965.925511117336;5829.795957141479;5860.970695146497;5875.089361149029;5876.294844618673;5913.970430147821;1498.1235976953387;1510.2448775612195;1512.8714059305082;1515.3484001879078;1522.0563250784585;964.3346091197052;992.4343124419156;993.9304248702666;1010.1060561403065;1021.923355748307;5556.416576259435;5581.553475721932;5588.580856435702;5591.944080559224;5632.943670563324;5962.3739507351975;5964.493018093511;5999.400059994053;6032.939670603326;6082.452579267887;5405.648632838853;5469.179623056573;5531.225628412026;5551.500364967173;5613.522850557667;3174;3177.9046628601177;3224.0650211438888;3246.5292532582644;3261.679019996905;5939.762409503572;6148.661823599656;6182.443580077815;6185.41238582334;6249.875042485577;6123.969380153071;6127.325994140641;6147.862645410613;6157.107219453154;6188.44304012641;5929.881402372014;6106.480949119375;6181.660008699565;6214.689265536705;6225.688715564203;5891.9116213255975;5910.822675319747;5974.312954010345;5987.341392446914;6005.3694362091355;5872.03111486617;5927.555433342431;5935.643861368331;5952.613080149777;5962.4633782959745;5898.4101589840675;6145.35473775265;6167.259928808572;6189.442950134509;6196.907046394217;4191.706580539333;4217.746935183899;4222.387753775624;4235.80938857746;4236.597523235288;5808.332041815245;5856.912146317723;6001.5798894077;6013.338532761481;6018.578699490994;5739.311282646109;5836.708164591669;5863.442972917566;5868.039073625371;5871.236739223874;5616.803411880564;5799.999000344874;5897.764089436375;5904.881902362014;5922.348541660328;5724.8282551523525;5757.884842303047;5772.365039845529;5799.478046975623;5804.767809287581;5919.644821310735;5939.970300148471;5942.257217847769;5954.10688396744;5964.671943043174;5448.809291674773;5757.193992841089;5763.106718458645;5803.941960580509;5837.6497410155525 17:15:53 INFO - PROCESS | 4474 | |5;yui.html;728.1407938632415;781.8397228568144;783.3615603283324;792.8731402975525;798.3573223555038;15046.398144074237;16136.677266454693;16161.919190404045;16206.189690515457;16230.756538651915;14352.928235358808;14544.490942817003;14546.272686365692;14560.635984100403;14563.053401528894;654.5712558274338;781.070526073973;797.4856217739555;800.4516905919464;802.0455657767268;769.5536588778523;774.802425381527;775.8681024225895;780.1808101493409;784.5606460382204;833.2500749325625;838.1367191792433;841.6717480182733;843.9915600844005;844.3456321350972;833.7207035643066;836.7196989008689;837.3092198935872;840.2563731098022;841.6675413211777;612.978545750901;613.7882430561449;613.9807918854724;613.9907901381483;615.8121772859276;14739.336729847182;14749.115053096848;14795.334209960578;14795.482158124414;14813.18527480988;14240.359183836752;14450;14489.710205795931;14492.782608260884;14620.780688289684;11104.500297486633;11193;11443.656690299304;11571.884281157165;11632.243904146288;3567.8216089195435;3609.169890925076;3664.486971823947;3681.355762741536;3693.113652723327;61607.69196154035;63435.36564634341;63892.68053659702;73585.63207183983;73944.63027684827;10411.5835366586;10523.84214236787;10655.147588192925;10819.080378167944;11078.612248571262;21190.258340958302;21198.36404907855;21300.78699213019;21360.57278854414;21362.679559806304;8461.70384036568;8468.280196183394;8490.448120872123;8504.14958504157;8687.956560217284;4413.095315460323;4423.845165419195;4465.419495465569;4535.841245556456;4555.157295900202;3479.1128262292955;3587.9103022424124;3587.9774264334537;3595.7482976191413;3622.239329740731;588.9764409423575;593.8010766393306;595.8540157661314;601.6119602856133;609.8658295175054;578.1239876600374;587.867729760809;596.6002778138658;674.5480528046123;676.1649363036646;9357.578908949114;9586;9645.662401816044;9765.218782497383;9840.311178217598;579.004112925767;593.418449919073;667.8063361625171;683.1597135523235;708.7802781137864;4125.1131006833675;4140.896477588024;4168.791560422027;4169.124483858363;4228.04868904494;103929;104426.79568366082;107032.46483767532;108602.45698771455;113170.43414782874;65210.29052606405;79670;81443;94463.52768236115;98369.48660524948;57813.71093144507;73629.6318518404;85204.57397712972;85353.57323213344;85813.57093214619;8253.504789712637;8489.363297752816;8538.445001075159;8548.74353769388;8684.131586841266;39903.80048099741;40940.59059409487;49194;50124.498755011984;54793;68033.65983170053;76854.61572692101;80229.59885200537;81607;81651.59174204328;12906.548270810477;13066.934665326613;13132.146410483288;13223.801642975171;13238;13577.79633305521;13704.766293548946;13709.685464321794;13825.51610693621;14337.283135843374;13754.862451375358;13795.931020344835;13854.65363365924;13986.510472133426;14271.857281427468;13172.275524846225;13215.801762973755;13396.062275640612;13491;13659;12441;13008.414621341873;13502.527411540548;13633.590992270249;13826.861731382558;11392.487338069972;11447.370394628375;11619.477123529292;11832.230904991147;12222.816657750318;11217.831732524182;11299.661010169708;11375.601853935073;11847.822282665595;11941.223820451643 17:15:53 INFO - PROCESS | 4474 | __end_tp_report 17:15:53 INFO - PROCESS | 4474 | __start_cc_report 17:15:53 INFO - PROCESS | 4474 | _x_x_mozilla_cycle_collect,337 17:15:53 INFO - PROCESS | 4474 | __end_cc_report 17:15:53 INFO - PROCESS | 4474 | __startTimestamp1464912953844__endTimestamp 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | ------- Summary: start ------- 17:15:53 INFO - PROCESS | 4474 | Number of tests: 6 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | [#0] dojo.html Cycles:165 Average:5306.50 Median:5467.23 stddev:716.13 (13.1%) stddev-sans-first:696.45 17:15:53 INFO - PROCESS | 4474 | Values: 3067.4 3104.5 3125.5 3130.1 3141.6 5265.0 5289.3 5338.6 5377.8 5398.4 5271.1 5292.2 5328.5 5429.9 5433.0 4906.1 4924.7 5004.0 5045.9 5092.9 523.9 4801.4 4862.4 4862.9 4956.0 4742.5 4822.5 4826.9 4840.1 4892.3 4825.4 4846.3 4846.9 4866.8 4905.7 4826.7 4847.1 4877.5 4897.5 4946.9 5238.6 5258.9 5293.7 5299.4 5319.7 5643.5 5754.9 5790.7 5807.5 5809.4 5724.3 5756.9 5812.7 5819.4 5839.7 5438.4 5440.4 5442.0 5447.2 5457.2 5779.3 5913.6 5972.2 6010.0 6019.7 5717.5 5792.7 5797.4 5798.1 5847.2 5844.1 5874.3 5881.4 5882.3 5898.0 5618.2 5641.8 5659.5 5810.4 5829.8 5693.9 5708.5 5718.1 5718.9 5762.2 4357.3 4382.2 4383.7 4398.7 4411.6 3837.2 3901.9 3924.5 3973.4 3992.2 5306.8 5325.2 5330.4 5342.6 5355.8 5661.9 5712.9 5729.5 5737.5 5761.9 5297.8 5313.2 5355.1 5404.1 5426.8 4932.9 4975.2 4978.1 4986.7 5038.3 5966.7 5993.9 5994.9 6001.1 6001.9 5566.7 5714.4 5744.2 5783.8 5785.3 5937.8 5962.8 6012.2 6013.6 6040.1 5554.7 5714.8 5721.5 5731.7 5733.2 5695.7 5700.3 5764.5 5774.5 5788.7 5604.6 5624.7 5637.9 5641.7 5647.6 5422.1 5576.1 5582.1 5611.4 5627.8 5367.1 5378.1 5400.8 5417.2 5467.2 5499.7 5502.7 5521.2 5536.8 5570.2 5391.9 5450.6 5495.6 5496.9 5498.0 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | [#1] ext.html Cycles:180 Average:56076.13 Median:21722.36 stddev:114685.98 (528.0%) stddev-sans-first:114932.02 17:15:53 INFO - PROCESS | 4474 | Values: 582.3 627.8 632.5 645.9 659.1 38811.0 42946.0 43067.0 43219.8 43266.8 43923.3 44361.0 44406.1 44439.3 44449.6 8513.1 8618.0 8625.7 8639.3 8651.2 8539.0 8542.6 8598.9 8603.5 8640.6 8587.2 8597.9 8671.3 8682.6 8707.4 8554.7 8650.4 8658.8 8665.1 8670.4 8722.7 8812.3 8817.1 8834.1 8837.8 39488.2 39940.2 39951.2 40004.2 40004.2 2842.3 3120.2 3283.9 3348.7 3446.6 29735.1 29822.7 30342.0 30351.8 30428.0 3941.0 3956.5 3962.0 4081.9 4134.8 304120.0 304280.0 304613.0 304734.0 305140.0 34304.0 34509.1 34609.8 34648.0 35320.6 36430.6 36511.3 36587.6 36718.6 36740.4 14043.6 14185.2 14186.1 14186.2 14226.7 11701.3 11817.7 11867.5 11891.7 11925.3 8341.4 8355.9 8404.8 8422.2 8482.9 3221.6 3299.8 3318.2 3320.0 3349.7 979.6 981.4 1040.0 1119.7 1126.2 30177.4 30441.4 30722.0 31037.7 31583.2 1076.0 1103.3 1121.0 1213.1 1214.3 16520.9 16687.9 16775.8 16843.6 16900.9 566099.0 569480.0 572524.0 573653.0 574878.0 57741.3 58164.4 58447.0 58629.7 58641.7 1312.9 1383.1 1391.3 1393.5 1395.7 30111.4 30873.0 31072.5 31206.0 31727.7 49714.3 50188.5 50364.0 50364.2 50431.7 368143.0 369287.0 369461.0 370908.0 371013.0 27702.7 27704.4 28881.9 28935.3 29956.4 48923.8 48990.3 49284.3 49823.3 49835.3 40350.2 40697.6 40854.8 41028.8 41871.0 39688.7 40788.8 41035.6 41136.8 41553.6 39844.4 40596.4 40815.0 40931.0 41094.6 35778.5 36913.0 37058.1 37102.4 37653.4 28102.4 28349.2 28377.8 28395.3 28502.3 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | [#2] jquery.html Cycles:180 Average:28495.36 Median:392.65 stddev:80212.33 (20428.2%) stddev-sans-first:80409.59 17:15:53 INFO - PROCESS | 4474 | Values: 390.8 394.5 398.0 402.7 417.9 13940.9 17824.1 19239.6 19377.8 19726.4 18249.4 18342.0 18572.1 19485.1 19538.2 5484.9 5574.2 5608.8 5650.3 5826.7 5708.6 5711.3 5750.1 5783.3 5788.6 5267.9 5541.7 5564.9 5661.3 5743.9 5508.7 5588.6 5593.1 5632.9 5944.0 5727.3 5757.0 5767.3 5775.5 5799.9 13402.7 16233.8 20693.2 22200.4 22306.1 2276.4 2323.7 2374.5 2490.3 2497.3 9935.3 10190.7 10245.5 10250.6 10525.4 1926.7 1941.0 1960.1 1974.0 2013.5 80143.6 81499.6 82886.6 83791.6 83887.0 10481.9 10889.1 10951.8 11059.6 11154.6 15242.4 15369.9 15435.2 15462.8 15478.5 7485.7 7511.1 7591.8 7613.4 7640.7 7066.3 7068.5 7097.2 7158.9 7183.1 4359.1 4376.9 4428.0 4437.4 4512.9 1918.2 1965.2 1969.1 1999.7 2004.1 920.9 983.0 999.5 1027.6 1045.7 18618.9 18864.6 19320.4 19472.1 19706.4 990.0 1019.4 1046.6 1080.5 1086.8 9340.3 10778.6 10870.4 10900.9 10920.8 472275.0 472796.0 488978.8 498712.0 499522.0 85711.0 87212.0 88344.6 88415.6 88765.1 995.0 996.3 1008.3 1024.8 1034.5 16817.8 17048.3 17231.1 17236.7 17429.9 39873.4 40024.0 40405.0 41065.4 41304.4 55104.2 56118.0 56974.4 57638.4 57882.7 8571.5 8600.5 8610.4 8753.4 8930.9 9800.7 12842.7 12919.5 13078.1 13418.1 11574.9 11642.4 11785.8 11799.2 12005.5 11363.2 11412.8 11486.5 11567.0 11628.8 11635.2 11650.4 11925.5 11986.6 12177.8 7202.2 7476.3 7897.3 8624.0 8714.4 8756.7 11626.7 11871.3 11913.6 12033.3 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | [#3] mootools.html Cycles:180 Average:5582.95 Median:2546.06 stddev:3147.11 (123.6%) stddev-sans-first:3140.80 17:15:53 INFO - PROCESS | 4474 | Values: 1475.1 1501.8 1633.8 1750.6 1769.8 7183.8 8006.1 8083.4 8473.8 8544.4 8100.5 8315.6 8352.1 8408.3 8448.2 2241.5 2263.2 2270.9 2272.2 2272.3 2251.3 2251.7 2292.6 2293.1 2294.3 2236.2 2242.8 2254.0 2268.1 2296.3 2202.0 2226.5 2230.9 2234.1 2237.8 2298.2 2314.4 2319.8 2326.7 2329.5 8472.3 8526.4 8531.0 8534.7 8548.2 4861.3 4927.7 4952.6 4955.3 4968.9 2854.0 2934.4 3011.6 3054.2 3054.4 997.2 1043.1 1048.7 1080.6 1086.0 11201.8 11217.0 11221.3 11232.6 11256.4 4169.5 4364.7 4383.2 4385.9 4395.7 9541.5 9586.1 9592.1 9617.5 9627.0 4936.0 4957.0 4959.3 4972.8 5002.0 4161.9 4632.8 4639.3 4693.8 4709.5 3898.2 3908.9 3954.4 3979.2 4048.0 1248.5 1289.5 1290.6 1294.4 1296.7 981.3 1004.3 1013.5 1015.6 1021.8 5933.3 5983.5 5989.2 6043.2 6176.9 446.9 448.9 451.4 452.2 459.3 4246.4 4246.8 4250.9 4259.4 4284.3 10298.3 10585.6 10624.5 10667.9 10684.4 10403.9 10487.3 10505.6 10515.0 10563.6 7621.3 7948.7 7971.0 8070.8 8107.4 5856.8 5898.8 5930.4 5983.1 6002.3 9543.4 9791.7 10035.6 10053.7 10055.3 9859.5 10025.6 10164.7 10232.2 10292.7 6707.8 6956.8 6991.9 7272.9 7565.8 8271.6 8285.0 8288.0 8299.9 8357.1 7250.0 7303.6 7528.8 7621.9 7694.5 7213.9 7236.6 7348.4 7431.9 7611.0 6769.3 6826.0 6849.5 6850.7 6858.7 5099.1 5176.6 5204.4 5306.2 5403.9 5152.5 5157.0 5186.6 5237.7 5250.2 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | [#4] prototype.html Cycles:180 Average:4914.07 Median:5590.26 stddev:1442.37 (25.8%) stddev-sans-first:1404.82 17:15:53 INFO - PROCESS | 4474 | Values: 332.2 334.4 334.9 336.5 344.4 5536.3 5600.9 5628.3 5675.7 5677.5 5538.7 5545.5 5563.6 5573.7 5587.6 4178.3 4208.9 4376.1 4387.7 4398.5 4354.0 4354.4 4409.7 4415.8 4428.1 4368.8 4373.0 4374.0 4381.5 4400.9 4238.8 4323.1 4325.2 4326.7 4347.9 3774.5 3804.8 3813.2 3824.5 3840.8 5371.1 5374.2 5375.0 5378.9 5445.2 4850.0 4910.3 4924.6 4936.8 4955.7 5725.7 5750.6 5778.9 5780.9 5810.0 4249.9 4257.9 4268.5 4272.9 4277.1 5825.4 6049.5 6066.2 6125.4 6153.6 4211.9 4218.6 4240.0 4255.6 4259.3 4276.3 4301.4 4308.8 4310.5 4332.6 4715.8 4832.3 4877.2 4886.2 4965.9 5829.8 5861.0 5875.1 5876.3 5914.0 1498.1 1510.2 1512.9 1515.3 1522.1 964.3 992.4 993.9 1010.1 1021.9 5556.4 5581.6 5588.6 5591.9 5632.9 5962.4 5964.5 5999.4 6032.9 6082.5 5405.6 5469.2 5531.2 5551.5 5613.5 3174.0 3177.9 3224.1 3246.5 3261.7 5939.8 6148.7 6182.4 6185.4 6249.9 6124.0 6127.3 6147.9 6157.1 6188.4 5929.9 6106.5 6181.7 6214.7 6225.7 5891.9 5910.8 5974.3 5987.3 6005.4 5872.0 5927.6 5935.6 5952.6 5962.5 5898.4 6145.4 6167.3 6189.4 6196.9 4191.7 4217.7 4222.4 4235.8 4236.6 5808.3 5856.9 6001.6 6013.3 6018.6 5739.3 5836.7 5863.4 5868.0 5871.2 5616.8 5800.0 5897.8 5904.9 5922.3 5724.8 5757.9 5772.4 5799.5 5804.8 5919.6 5940.0 5942.3 5954.1 5964.7 5448.8 5757.2 5763.1 5803.9 5837.6 17:15:53 INFO - PROCESS | 4474 | 17:15:53 INFO - PROCESS | 4474 | [#5] yui.html Cycles:180 Average:19546.00 Median:4198.59 stddev:27481.55 (654.5%) stddev-sans-first:27522.31 17:15:53 INFO - PROCESS | 4474 | Values: 728.1 781.8 783.4 792.9 798.4 15046.4 16136.7 16161.9 16206.2 16230.8 14352.9 14544.5 14546.3 14560.6 14563.1 654.6 781.1 797.5 800.5 802.0 769.6 774.8 775.9 780.2 784.6 833.3 838.1 841.7 844.0 844.3 833.7 836.7 837.3 840.3 841.7 613.0 613.8 614.0 614.0 615.8 14739.3 14749.1 14795.3 14795.5 14813.2 14240.4 14450.0 14489.7 14492.8 14620.8 11104.5 11193.0 11443.7 11571.9 11632.2 3567.8 3609.2 3664.5 3681.4 3693.1 61607.7 63435.4 63892.7 73585.6 73944.6 10411.6 10523.8 10655.1 10819.1 11078.6 21190.3 21198.4 21300.8 21360.6 21362.7 8461.7 8468.3 8490.4 8504.1 8688.0 4413.1 4423.8 4465.4 4535.8 4555.2 3479.1 3587.9 3588.0 3595.7 3622.2 589.0 593.8 595.9 601.6 609.9 578.1 587.9 596.6 674.5 676.2 9357.6 9586.0 9645.7 9765.2 9840.3 579.0 593.4 667.8 683.2 708.8 4125.1 4140.9 4168.8 4169.1 4228.0 103929.0 104426.8 107032.5 108602.5 113170.4 65210.3 79670.0 81443.0 94463.5 98369.5 57813.7 73629.6 85204.6 85353.6 85813.6 8253.5 8489.4 8538.4 8548.7 8684.1 39903.8 40940.6 49194.0 50124.5 54793.0 68033.7 76854.6 80229.6 81607.0 81651.6 12906.5 13066.9 13132.1 13223.8 13238.0 13577.8 13704.8 13709.7 13825.5 14337.3 13754.9 13795.9 13854.7 13986.5 14271.9 13172.3 13215.8 13396.1 13491.0 13659.0 12441.0 13008.4 13502.5 13633.6 13826.9 11392.5 11447.4 11619.5 11832.2 12222.8 11217.8 11299.7 11375.6 11847.8 11941.2 17:15:53 INFO - PROCESS | 4474 | -------- Summary: end -------- 17:15:53 INFO - PROCESS | 4474 | 17:15:54 INFO - TEST-INFO | 4474: exit 0 17:15:54 INFO - TEST-OK | dromaeo_css | took 1109321ms 17:15:54 INFO - TEST-START | kraken 17:15:54 INFO - operating with platform_type : linux_ 17:15:54 INFO - Initialising browser for kraken test... 17:15:54 INFO - TEST-INFO | started process 4710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWDVz1/profile http://localhost:56352/getInfo.html) 17:15:59 INFO - PROCESS | 4710 | __metrics Screen width/height:1600/1200 17:15:59 INFO - PROCESS | 4710 | colorDepth:24 17:15:59 INFO - PROCESS | 4710 | Browser inner width/height: 1024/697 17:15:59 INFO - PROCESS | 4710 | __metrics 17:15:59 ERROR - PROCESS | 4710 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:16:00 INFO - TEST-INFO | 4710: exit 0 17:16:00 INFO - Browser initialized. 17:16:00 INFO - Running cycle 1/1 for kraken test... 17:16:00 INFO - TEST-INFO | started process 4831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWDVz1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:12 INFO - PROCESS | 4831 | RSS: Main: 166711296 17:16:12 INFO - PROCESS | 4831 | 17:16:14 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56352/tests/kraken/driver.html?testName=audio-beat-detection) 17:16:15 INFO - PROCESS | 4831 | RSS: Main: 171921408 17:16:15 INFO - PROCESS | 4831 | 17:16:18 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56352/tests/kraken/driver.html?testName=audio-dft) 17:16:19 INFO - PROCESS | 4831 | RSS: Main: 171458560 17:16:19 INFO - PROCESS | 4831 | 17:16:22 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56352/tests/kraken/driver.html?testName=audio-fft) 17:16:22 INFO - PROCESS | 4831 | RSS: Main: 166395904 17:16:22 INFO - PROCESS | 4831 | 17:16:25 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56352/tests/kraken/driver.html?testName=audio-oscillator) 17:16:25 INFO - PROCESS | 4831 | RSS: Main: 167641088 17:16:25 INFO - PROCESS | 4831 | 17:16:27 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56352/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:16:28 INFO - PROCESS | 4831 | RSS: Main: 167878656 17:16:28 INFO - PROCESS | 4831 | 17:16:31 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56352/tests/kraken/driver.html?testName=imaging-darkroom) 17:16:32 INFO - PROCESS | 4831 | RSS: Main: 168140800 17:16:32 INFO - PROCESS | 4831 | 17:16:35 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56352/tests/kraken/driver.html?testName=imaging-desaturate) 17:16:36 INFO - PROCESS | 4831 | RSS: Main: 165728256 17:16:36 INFO - PROCESS | 4831 | 17:16:39 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56352/tests/kraken/driver.html?testName=json-parse-financial) 17:16:39 INFO - PROCESS | 4831 | RSS: Main: 166510592 17:16:39 INFO - PROCESS | 4831 | 17:16:41 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56352/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:16:41 INFO - PROCESS | 4831 | RSS: Main: 167018496 17:16:41 INFO - PROCESS | 4831 | 17:16:43 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:44 INFO - PROCESS | 4831 | RSS: Main: 167239680 17:16:44 INFO - PROCESS | 4831 | 17:16:46 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:47 INFO - PROCESS | 4831 | RSS: Main: 168071168 17:16:47 INFO - PROCESS | 4831 | 17:16:49 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:50 INFO - PROCESS | 4831 | RSS: Main: 167944192 17:16:50 INFO - PROCESS | 4831 | 17:16:53 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:53 INFO - PROCESS | 4831 | RSS: Main: 167895040 17:16:53 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:56352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56352/tests/kraken/driver.html?testName=ai-astar) 17:16:55 INFO - PROCESS | 4831 | RSS: Main: 168534016 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | __start_tp_report 17:16:55 INFO - PROCESS | 4831 | _x_x_mozilla_page_load 17:16:55 INFO - PROCESS | 4831 | _x_x_mozilla_page_load_details 17:16:55 INFO - PROCESS | 4831 | |i|pagename|runs| 17:16:55 INFO - PROCESS | 4831 | |0;ai-astar;112;108;111;111;116;112;113;110;112;114 17:16:55 INFO - PROCESS | 4831 | |1;audio-beat-detection;162;129;159;177;126;156;158;128;194;134 17:16:55 INFO - PROCESS | 4831 | |2;audio-dft;163;164;161;162;161;176;163;163;162;166 17:16:55 INFO - PROCESS | 4831 | |3;audio-fft;75;76;76;161;76;76;74;75;163;74 17:16:55 INFO - PROCESS | 4831 | |4;audio-oscillator;84;84;143;84;83;84;150;83;85;137 17:16:55 INFO - PROCESS | 4831 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;117;117;117 17:16:55 INFO - PROCESS | 4831 | |6;imaging-darkroom;148;147;148;149;146;147;146;149;148;147 17:16:55 INFO - PROCESS | 4831 | |7;imaging-desaturate;96;95;96;95;95;95;95;96;95;95 17:16:55 INFO - PROCESS | 4831 | |8;json-parse-financial;54;59;56;55;55;55;57;55;54;55 17:16:55 INFO - PROCESS | 4831 | |9;json-stringify-tinderbox;63;64;63;65;63;67;62;63;62;62 17:16:55 INFO - PROCESS | 4831 | |10;stanford-crypto-aes;86;80;83;80;81;79;81;80;112;81 17:16:55 INFO - PROCESS | 4831 | |11;stanford-crypto-ccm;132;132;135;122;121;120;141;137;146;133 17:16:55 INFO - PROCESS | 4831 | |12;stanford-crypto-pbkdf2;165;170;164;173;167;166;164;167;165;162 17:16:55 INFO - PROCESS | 4831 | |13;stanford-crypto-sha256-iterative;63;64;65;63;64;65;64;63;63;64 17:16:55 INFO - PROCESS | 4831 | __end_tp_report 17:16:55 INFO - PROCESS | 4831 | __start_cc_report 17:16:55 INFO - PROCESS | 4831 | _x_x_mozilla_cycle_collect,894 17:16:55 INFO - PROCESS | 4831 | __end_cc_report 17:16:55 INFO - PROCESS | 4831 | __startTimestamp1464913015658__endTimestamp 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | ------- Summary: start ------- 17:16:55 INFO - PROCESS | 4831 | Number of tests: 14 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:2.18 (1.9%) stddev-sans-first:2.32 17:16:55 INFO - PROCESS | 4831 | Values: 112.0 108.0 111.0 111.0 116.0 112.0 113.0 110.0 112.0 114.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:158.50 stddev:22.84 (14.4%) stddev-sans-first:23.95 17:16:55 INFO - PROCESS | 4831 | Values: 162.0 129.0 159.0 177.0 126.0 156.0 158.0 128.0 194.0 134.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:4.43 (2.7%) stddev-sans-first:4.68 17:16:55 INFO - PROCESS | 4831 | Values: 163.0 164.0 161.0 162.0 161.0 176.0 163.0 163.0 162.0 166.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.50 stddev:36.59 (48.5%) stddev-sans-first:38.25 17:16:55 INFO - PROCESS | 4831 | Values: 75.0 76.0 76.0 161.0 76.0 76.0 74.0 75.0 163.0 74.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:84.00 stddev:28.90 (34.4%) stddev-sans-first:29.93 17:16:55 INFO - PROCESS | 4831 | Values: 84.0 84.0 143.0 84.0 83.0 84.0 150.0 83.0 85.0 137.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:16:55 INFO - PROCESS | 4831 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:16:55 INFO - PROCESS | 4831 | Values: 148.0 147.0 148.0 149.0 146.0 147.0 146.0 149.0 148.0 147.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:16:55 INFO - PROCESS | 4831 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.51 (2.7%) stddev-sans-first:1.50 17:16:55 INFO - PROCESS | 4831 | Values: 54.0 59.0 56.0 55.0 55.0 55.0 57.0 55.0 54.0 55.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 17:16:55 INFO - PROCESS | 4831 | Values: 63.0 64.0 63.0 65.0 63.0 67.0 62.0 63.0 62.0 62.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:9.93 (12.3%) stddev-sans-first:10.52 17:16:55 INFO - PROCESS | 4831 | Values: 86.0 80.0 83.0 80.0 81.0 79.0 81.0 80.0 112.0 81.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:134.00 stddev:8.67 (6.5%) stddev-sans-first:9.20 17:16:55 INFO - PROCESS | 4831 | Values: 132.0 132.0 135.0 122.0 121.0 120.0 141.0 137.0 146.0 133.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:3.20 (1.9%) stddev-sans-first:3.36 17:16:55 INFO - PROCESS | 4831 | Values: 165.0 170.0 164.0 173.0 167.0 166.0 164.0 167.0 165.0 162.0 17:16:55 INFO - PROCESS | 4831 | 17:16:55 INFO - PROCESS | 4831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 17:16:55 INFO - PROCESS | 4831 | Values: 63.0 64.0 65.0 63.0 64.0 65.0 64.0 63.0 63.0 64.0 17:16:55 INFO - PROCESS | 4831 | -------- Summary: end -------- 17:16:55 INFO - PROCESS | 4831 | 17:16:56 INFO - TEST-INFO | 4831: exit 0 17:16:56 INFO - TEST-OK | kraken | took 62038ms 17:16:56 INFO - SUITE-END | took 1171s 17:16:56 INFO - Completed test suite (00:19:31) 17:16:56 INFO - javascript benchmark 17:16:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7066.340294840998, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.386522695461, 3104.5032794752815, 3125.5155450905104, 3130.076627394919, 3141.607299087614, 5264.973675131624, 5289.312389389374, 5338.599605029619, 5377.838664840051, 5398.406175320712, 5271.051210782058, 5292.153255479124, 5328.49379308966, 5429.945700542993, 5433.049216387127, 4906.1168989581865, 4924.729139897304, 5004.0, 5045.924311135336, 5092.898142037157, 523.8876110778615, 4801.447833499157, 4862.367892174012, 4862.927056094161, 4955.975220123894, 4742.454617718972, 4822.4936381679945, 4826.9034619307595, 4840.104580652591, 4892.2661600760175, 4825.445073816521, 4846.273059041137, 4846.854594362175, 4866.829660961849, 4905.656604037718, 4826.710397376169, 4847.079054979543, 4877.487863774288, 4897.4857639948, 4946.9010619787405, 5238.633295669305, 5258.92111618326, 5293.682379057231, 5299.417064122943, 5319.654222475527, 5643.520300774439, 5754.88490230193, 5790.652560846363, 5807.535397168216, 5809.419058094157, 5724.2558467399385, 5756.884862302731, 5812.680302583356, 5819.388964158745, 5839.678817665027, 5438.374586922476, 5440.3743569489225, 5441.972790136024, 5447.1829225616075, 5457.181422786574, 5779.33537643168, 5913.645181289136, 5972.223610930551, 6010.038393856962, 6019.729112189962, 5717.542596592262, 5792.652440853562, 5797.449242321973, 5798.072308430631, 5847.152162936351, 5844.094165404369, 5874.324452687995, 5881.3530511643685, 5882.323532793698, 5898.026825573732, 5618.213450116987, 5641.774329026875, 5659.490645841812, 5810.360860305363, 5829.766809327664, 5693.886122277531, 5708.543316534668, 5718.056520674042, 5718.857028574235, 5762.164486149485, 4357.302831547001, 4382.211201983673, 4383.736975781463, 4398.73607583546, 4411.625011874026, 3837.175007373428, 3901.902452438655, 3924.47019652349, 3973.443717879499, 3992.161646054361, 5306.814261500829, 5325.227841962894, 5330.360356757214, 5342.626016178908, 5355.839324820262, 5661.886762264731, 5712.885742285131, 5729.541636669056, 5737.540996720252, 5761.85595360111, 5297.788088476418, 5313.203019547099, 5355.062863998784, 5404.108322126884, 5426.782928682887, 4932.90134197314, 4975.179095449211, 4978.079055374767, 4986.675866068694, 5038.294638750578, 5966.731497082642, 5993.910091348634, 5994.880102397928, 6001.12983617373, 6001.939980600138, 5566.749496272678, 5714.371419143974, 5744.167095771173, 5783.826485205451, 5785.27684039495, 5937.7921772737745, 5962.821115366546, 6012.248468941382, 6013.579049466495, 6040.09398590215, 5554.694491802989, 5714.79998200061, 5721.485066344049, 5731.656100633975, 5733.197352370588, 5695.686737229492, 5700.25896633435, 5764.481196692318, 5774.48029677331, 5788.652680839163, 5604.579656525695, 5624.7187640616985, 5637.88724225505, 5641.746121424628, 5647.632903861236, 5422.132458806572, 5576.10782274834, 5582.051051321204, 5611.410801865745, 5627.774889004394, 5367.087595108763, 5378.085725426765, 5400.783968641367, 5417.160340147283, 5467.234587157722, 5499.7250137492165, 5502.697351645698, 5521.171824226238, 5536.7819079802375, 5570.220169176399, 5391.892162156813, 5450.563954883521, 5495.626093476631, 5496.917546236889, 5498.0], "value": 5260.003685649125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2634367525081, 627.8493161641205, 632.5319263744827, 645.8901986662266, 659.1003280522089, 38811.0, 42946.0, 43067.0, 43219.78390108053, 43266.783666081705, 43923.34114988278, 44361.0, 44406.11187776243, 44439.33340999888, 44449.55550444494, 8513.148685131498, 8618.0, 8625.698100566482, 8639.265662418702, 8651.221390074892, 8539.0, 8542.615582298811, 8598.87101693475, 8603.48379097253, 8640.611172497222, 8587.227149556538, 8597.914020859806, 8671.306295496344, 8682.609282582267, 8707.390482666184, 8554.657813687445, 8650.394472386935, 8658.783530411758, 8665.09016553259, 8670.393072484929, 8722.738317850475, 8812.339074569432, 8817.074207208216, 8834.07242239562, 8837.823243535158, 39488.21023579541, 39940.20119597592, 39951.20097598061, 40004.19991600181, 40004.19991600181, 2842.2610121368384, 3120.204347891296, 3283.9014829555153, 3348.68187522185, 3446.638102999199, 29735.107946761633, 29822.70177298221, 30342.0, 30351.848240758656, 30428.0, 3941.0, 3956.5054368203973, 3962.0491082140366, 4081.89795255121, 4134.772587507686, 304120.0, 304279.9999999978, 304613.0, 304734.0, 305140.0, 34304.0, 34509.13727156841, 34609.826950865085, 34648.0, 35320.64679353225, 36430.63569364326, 36511.269774604356, 36587.63412365896, 36718.632813672055, 36740.44889326662, 14043.578692639237, 14185.219812910389, 14186.077904936146, 14186.219757913208, 14226.715465690628, 11701.2979221247, 11817.704557386134, 11867.525298988117, 11891.702707432383, 11925.34410607425, 8341.416100873003, 8355.916440835636, 8404.831903362021, 8422.199891010345, 8482.872756908651, 3221.597300337458, 3299.785513941586, 3318.2368055346924, 3319.9502007469905, 3349.69852713257, 979.5836769372988, 981.3572110267786, 1040.0447159340392, 1119.7200699825044, 1126.2003977176132, 30177.437896736406, 30441.39117217643, 30722.0, 31037.68962310393, 31583.21041973969, 1076.0423223331086, 1103.27184058521, 1121.0, 1213.096243298748, 1214.2532342609231, 16520.917395413187, 16687.91656041736, 16775.832241677672, 16843.592371135994, 16900.915495422443, 566099.0, 569480.0, 572524.0, 573653.0, 574878.0, 57741.2969146787, 58164.41835581675, 58447.0, 58629.706851466326, 58641.70679146577, 1312.934353282332, 1383.087162472763, 1391.325207274471, 1393.4913756478811, 1395.7208558288382, 30111.397772044875, 30873.0, 31072.533911990886, 31206.0, 31727.682723173395, 49714.254286185016, 50188.498115019844, 50364.0, 50364.24453633272, 50431.747841260556, 368143.0, 369287.0, 369461.0, 370908.0, 371013.0, 27702.722972770014, 27704.445911082068, 28881.855590721912, 28935.276618084717, 29956.400871982, 48923.755381222865, 48990.26514602355, 49284.2607360897, 49823.25265121098, 49835.25247121223, 40350.1929961405, 40697.59302406938, 40854.79572602118, 41028.79485602553, 41871.0, 39688.71206365648, 40788.79605601953, 41035.576256070715, 41136.79431602823, 41553.58446415497, 39844.40233396559, 40596.3910541348, 40815.0, 40931.0, 41094.58905410908, 35778.463323049655, 36913.0, 37058.14709264472, 37102.44346334753, 37653.435198471496, 28102.437951240452, 28349.1634542784, 28377.787059689912, 28395.320935812506, 28502.28986260831], "value": 18268.254262219296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.7831153709692, 394.5265681182582, 397.9502562179726, 402.67182246469133, 417.90388210711535, 13940.93029534851, 17824.10879456027, 19239.61520769584, 19377.806221937793, 19726.40820775379, 18249.36127235547, 18342.0, 18572.07139643019, 19485.123169457373, 19538.218471261167, 5484.862878428041, 5574.163875418679, 5608.831735047935, 5650.29371328584, 5826.679532625704, 5708.600397972144, 5711.314642242916, 5750.05124154514, 5783.277090363705, 5788.6237394569425, 5267.894642107156, 5541.722913854312, 5564.86087847803, 5661.320641523002, 5743.942560574383, 5508.6970216638065, 5588.580856435763, 5593.105103183491, 5632.943670563303, 5944.0, 5727.255456790591, 5756.971215143939, 5767.250257466544, 5775.537956963432, 5799.9130013049835, 13402.664933376744, 16233.83766162335, 20693.241074508685, 22200.444988875246, 22306.107755689754, 2276.362618466832, 2323.7095363079616, 2374.4776149247136, 2490.2902672738182, 2497.250824752567, 9935.304528682995, 10190.694279171637, 10245.48772561369, 10250.58997640101, 10525.36847789135, 1926.6724656808376, 1940.9708854367195, 1960.1081507913866, 1973.9703904441444, 2013.496625843539, 80143.59928200321, 81499.5925020377, 82886.58556707177, 83791.5810420944, 83887.0, 10481.947590262153, 10889.062000639195, 10951.83572246417, 11059.557617695364, 11154.60958866452, 15242.3903043877, 15369.923150384177, 15435.228238588026, 15462.768058479132, 15478.5356439307, 7485.663145158481, 7511.136219334737, 7591.772246832494, 7613.42899282556, 7640.73257435987, 7066.340538112054, 7068.469864760164, 7097.21930587635, 7158.92616107588, 7183.06620139389, 4359.14996575671, 4376.868693939124, 4427.977860110744, 4437.356583295404, 4512.864614061584, 1918.194358369488, 1965.2335589120255, 1969.0745349685624, 1999.7000449932627, 2004.0981558298824, 920.9493477858782, 983.0317137619439, 999.4552968632113, 1027.5684212630713, 1045.6862941117633, 18618.906905465385, 18864.622707545772, 19320.4203873884, 19472.123754431086, 19706.408807735792, 989.9505024748734, 1019.4291196929743, 1046.581367453025, 1080.4975686305747, 1086.820674588684, 9340.34617576763, 10778.568857245622, 10870.402127883042, 10900.890991090146, 10920.836187457195, 472275.0, 472796.0, 488978.76744174166, 498712.0, 499522.0, 85711.0, 87212.0, 88344.5582772082, 88415.55792220998, 88765.11234887698, 995.0397866059287, 996.272720913737, 1008.3445760255746, 1024.779672370444, 1034.4879284754095, 16817.831821681626, 17048.31806727717, 17231.138443078045, 17236.741448878027, 17429.912850435667, 39873.401898972115, 40024.0, 40405.0, 41065.384019239136, 41304.38043429291, 55104.17343739927, 56118.0, 56974.43025569857, 57638.423615763306, 57882.710586446796, 8571.528565928933, 8600.526971016403, 8610.354223433393, 8753.387262891536, 8930.86603700932, 9800.705978820646, 12842.743145136857, 12919.547815826401, 13078.149920255153, 13418.127821691558, 11574.942125289319, 11642.417879105842, 11785.764284714429, 11799.233049851731, 12005.519779209084, 11363.204575679623, 11412.771744565229, 11486.483108259981, 11567.0, 11628.767424651629, 11635.185537012328, 11650.359230242419, 11925.522979081086, 11986.580469683518, 12177.817332740193, 7202.243764404871, 7476.289752473506, 7897.328727058264, 8623.956880215559, 8714.433561818461, 8756.737297881074, 11626.651200463999, 11871.347075910908, 11913.642590722293, 12033.278003319829], "value": 9040.6126471242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.085447022846, 1501.8347981722009, 1633.8447847454495, 1750.571110078031, 1769.7699299091125, 7183.82040448989, 8006.119326874046, 8083.43415960883, 8473.830523389528, 8544.401891867572, 8100.51396916184, 8315.584220788967, 8352.081271060179, 8408.285295749853, 8448.23965843074, 2241.506868488934, 2263.207877242968, 2270.9318720438414, 2272.1820144747876, 2272.2728726807427, 2251.324602619216, 2251.6735073414425, 2292.5758734634064, 2293.0713061210154, 2294.265834932822, 2236.1614394602025, 2242.7532971373216, 2253.9774602254015, 2268.1494439585153, 2296.2651951375565, 2201.966970495444, 2226.532428190074, 2230.944226394337, 2234.061694088479, 2237.8209743220505, 2298.1841446286494, 2314.3751187179537, 2319.8376113672048, 2326.732425771041, 2329.5457385809773, 8472.322214222848, 8526.403151779377, 8531.01893282268, 8534.658613655447, 8548.230659240699, 4861.295112208745, 4927.6550641455115, 4952.579030782388, 4955.331030310898, 4968.90062198754, 2853.9714602853915, 2934.3691106412225, 3011.623547056618, 3054.205906464313, 3054.404391143728, 997.1922742578535, 1043.128987295609, 1048.6958781953224, 1080.5785743560018, 1086.0334302470808, 11201.831972520418, 11217.0, 11221.326720396803, 11232.55069797199, 11256.437178141143, 4169.478815148106, 4364.738115713068, 4383.189110014658, 4385.890352741207, 4395.670324725595, 9541.47521886303, 9586.089321514444, 9592.08875156859, 9617.461206206974, 9627.0, 4936.037472692862, 4957.0, 4959.256111583291, 4972.825951091694, 5002.049610573979, 4161.895952601149, 4632.837850675278, 4639.327297541905, 4693.812247510062, 4709.458412282632, 3898.161895192547, 3908.882733517999, 3954.4463775071513, 3979.164375481181, 4048.0, 1248.5318005747845, 1289.5035411366691, 1290.5676598339473, 1294.3592921503728, 1296.6563860576955, 981.3375971219398, 1004.2769206171545, 1013.5185786751234, 1015.5531566110888, 1021.8416145497459, 5933.317668468181, 5983.521318294526, 5989.1914591529585, 6043.153958445821, 6176.8764624707255, 446.8525386622407, 448.91470620581987, 451.41090876406605, 452.17252428057236, 459.28122488305695, 4246.363045543193, 4246.787660616957, 4250.851220207278, 4259.403683484315, 4284.314509678499, 10298.279120461646, 10585.576576936835, 10624.468776561142, 10667.946660266649, 10684.412357320267, 10403.94798026005, 10487.318324308895, 10505.579776808994, 10515.0, 10563.63027294041, 7621.275978782118, 7948.6820527179425, 7970.960145199237, 8070.83858322842, 8107.391945604103, 5856.824295271149, 5898.764049437975, 5930.406959304035, 5983.1025346196675, 6002.309734380602, 9543.42739435636, 9791.706248812547, 10035.598576056876, 10053.748656283358, 10055.296129271173, 9859.507024648596, 10025.649102281384, 10164.695059148238, 10232.232582556488, 10292.742681433025, 6707.765228216989, 6956.826079347854, 6991.895121573282, 7272.854542909218, 7565.773026809205, 8271.627776750182, 8284.958575207085, 8288.0, 8299.917000829915, 8357.08072112055, 7250.0, 7303.561786292839, 7528.811779705551, 7621.923780762343, 7694.538327700356, 7213.9278607213255, 7236.565806051653, 7348.448866334939, 7431.925680743123, 7611.048618922635, 6769.323067693192, 6826.044353790573, 6849.452043836581, 6850.657467126524, 6858.6570671467225, 5099.133147365031, 5176.637635365489, 5204.401493828107, 5306.177542480922, 5403.9459605403445, 5152.4847515248175, 5157.045946499909, 5186.6369354144845, 5237.659552129099, 5250.238715386324], "value": 4420.333301071672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.19111463586165, 334.3663757180143, 334.9296647703982, 336.5002970588674, 344.43512639271586, 5536.307961504812, 5600.887982240352, 5628.268325117734, 5675.659460432377, 5677.545796336293, 5538.695371754552, 5545.528630066449, 5563.554915606752, 5573.749181286842, 5587.580931430139, 4178.310578754509, 4208.936865947013, 4376.059147283333, 4387.692861499696, 4398.516163222043, 4354.0, 4354.368616550598, 4409.713368631044, 4415.8233670653135, 4428.136513379892, 4368.847090351823, 4372.978135109336, 4374.0, 4381.474223093217, 4400.921774165318, 4238.770756480632, 4323.113761678864, 4325.199838029975, 4326.6754993375625, 4347.913041739147, 3774.452704357853, 3804.7907365094907, 3813.2182902505197, 3824.541055073409, 3840.7695538267512, 5371.060064488699, 5374.193870919355, 5375.0, 5378.946210537883, 5445.1832225166545, 4849.951500484985, 4910.337104490884, 4924.630652701062, 4936.80252789888, 4955.653104282702, 5725.740337125826, 5750.568707346965, 5778.855528611776, 5780.8843823123725, 5809.970950145223, 4249.87250382489, 4257.87226383209, 4268.466441694788, 4272.931767058236, 4277.144571085764, 5825.359210486843, 6049.546284028672, 6066.150738896602, 6125.418085281891, 6153.630922045353, 4211.936820947688, 4218.6414154797185, 4239.957600424018, 4255.616994470451, 4259.297215959332, 4276.337167739005, 4301.376300436419, 4308.849190278325, 4310.4611923509565, 4332.610065094157, 4715.81136754526, 4832.299316599074, 4877.170880950247, 4886.193778026586, 4965.925511117336, 5829.795957141479, 5860.970695146497, 5875.089361149029, 5876.294844618673, 5913.970430147821, 1498.1235976953387, 1510.2448775612195, 1512.8714059305082, 1515.3484001879078, 1522.0563250784585, 964.3346091197052, 992.4343124419156, 993.9304248702666, 1010.1060561403065, 1021.923355748307, 5556.416576259435, 5581.553475721932, 5588.580856435702, 5591.944080559224, 5632.943670563324, 5962.3739507351975, 5964.493018093511, 5999.400059994053, 6032.939670603326, 6082.452579267887, 5405.648632838853, 5469.179623056573, 5531.225628412026, 5551.500364967173, 5613.522850557667, 3174.0, 3177.9046628601177, 3224.0650211438888, 3246.5292532582644, 3261.679019996905, 5939.762409503572, 6148.661823599656, 6182.443580077815, 6185.41238582334, 6249.875042485577, 6123.969380153071, 6127.325994140641, 6147.862645410613, 6157.107219453154, 6188.44304012641, 5929.881402372014, 6106.480949119375, 6181.660008699565, 6214.689265536705, 6225.688715564203, 5891.9116213255975, 5910.822675319747, 5974.312954010345, 5987.341392446914, 6005.3694362091355, 5872.03111486617, 5927.555433342431, 5935.643861368331, 5952.613080149777, 5962.4633782959745, 5898.4101589840675, 6145.35473775265, 6167.259928808572, 6189.442950134509, 6196.907046394217, 4191.706580539333, 4217.746935183899, 4222.387753775624, 4235.80938857746, 4236.597523235288, 5808.332041815245, 5856.912146317723, 6001.5798894077, 6013.338532761481, 6018.578699490994, 5739.311282646109, 5836.708164591669, 5863.442972917566, 5868.039073625371, 5871.236739223874, 5616.803411880564, 5799.999000344874, 5897.764089436375, 5904.881902362014, 5922.348541660328, 5724.8282551523525, 5757.884842303047, 5772.365039845529, 5799.478046975623, 5804.767809287581, 5919.644821310735, 5939.970300148471, 5942.257217847769, 5954.10688396744, 5964.671943043174, 5448.809291674773, 5757.193992841089, 5763.106718458645, 5803.941960580509, 5837.6497410155525], "value": 4451.30110087027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.1407938632415, 781.8397228568144, 783.3615603283324, 792.8731402975525, 798.3573223555038, 15046.398144074237, 16136.677266454693, 16161.919190404045, 16206.189690515457, 16230.756538651915, 14352.928235358808, 14544.490942817003, 14546.272686365692, 14560.635984100403, 14563.053401528894, 654.5712558274338, 781.070526073973, 797.4856217739555, 800.4516905919464, 802.0455657767268, 769.5536588778523, 774.802425381527, 775.8681024225895, 780.1808101493409, 784.5606460382204, 833.2500749325625, 838.1367191792433, 841.6717480182733, 843.9915600844005, 844.3456321350972, 833.7207035643066, 836.7196989008689, 837.3092198935872, 840.2563731098022, 841.6675413211777, 612.978545750901, 613.7882430561449, 613.9807918854724, 613.9907901381483, 615.8121772859276, 14739.336729847182, 14749.115053096848, 14795.334209960578, 14795.482158124414, 14813.18527480988, 14240.359183836752, 14450.0, 14489.710205795931, 14492.782608260884, 14620.780688289684, 11104.500297486633, 11193.0, 11443.656690299304, 11571.884281157165, 11632.243904146288, 3567.8216089195435, 3609.169890925076, 3664.486971823947, 3681.355762741536, 3693.113652723327, 61607.69196154035, 63435.36564634341, 63892.68053659702, 73585.63207183983, 73944.63027684827, 10411.5835366586, 10523.84214236787, 10655.147588192925, 10819.080378167944, 11078.612248571262, 21190.258340958302, 21198.36404907855, 21300.78699213019, 21360.57278854414, 21362.679559806304, 8461.70384036568, 8468.280196183394, 8490.448120872123, 8504.14958504157, 8687.956560217284, 4413.095315460323, 4423.845165419195, 4465.419495465569, 4535.841245556456, 4555.157295900202, 3479.1128262292955, 3587.9103022424124, 3587.9774264334537, 3595.7482976191413, 3622.239329740731, 588.9764409423575, 593.8010766393306, 595.8540157661314, 601.6119602856133, 609.8658295175054, 578.1239876600374, 587.867729760809, 596.6002778138658, 674.5480528046123, 676.1649363036646, 9357.578908949114, 9586.0, 9645.662401816044, 9765.218782497383, 9840.311178217598, 579.004112925767, 593.418449919073, 667.8063361625171, 683.1597135523235, 708.7802781137864, 4125.1131006833675, 4140.896477588024, 4168.791560422027, 4169.124483858363, 4228.04868904494, 103929.0, 104426.79568366082, 107032.46483767532, 108602.45698771455, 113170.43414782874, 65210.29052606405, 79670.0, 81443.0, 94463.52768236115, 98369.48660524948, 57813.71093144507, 73629.6318518404, 85204.57397712972, 85353.57323213344, 85813.57093214619, 8253.504789712637, 8489.363297752816, 8538.445001075159, 8548.74353769388, 8684.131586841266, 39903.80048099741, 40940.59059409487, 49194.0, 50124.498755011984, 54793.0, 68033.65983170053, 76854.61572692101, 80229.59885200537, 81607.0, 81651.59174204328, 12906.548270810477, 13066.934665326613, 13132.146410483288, 13223.801642975171, 13238.0, 13577.79633305521, 13704.766293548946, 13709.685464321794, 13825.51610693621, 14337.283135843374, 13754.862451375358, 13795.931020344835, 13854.65363365924, 13986.510472133426, 14271.857281427468, 13172.275524846225, 13215.801762973755, 13396.062275640612, 13491.0, 13659.0, 12441.0, 13008.414621341873, 13502.527411540548, 13633.590992270249, 13826.861731382558, 11392.487338069972, 11447.370394628375, 11619.477123529292, 11832.230904991147, 12222.816657750318, 11217.831732524182, 11299.661010169708, 11375.601853935073, 11847.822282665595, 11941.223820451643], "value": 7282.882198234463, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 111.0, 111.0, 116.0, 112.0, 113.0, 110.0, 112.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 159.0, 177.0, 126.0, 156.0, 158.0, 128.0, 194.0, 134.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 161.0, 176.0, 163.0, 163.0, 162.0, 166.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 161.0, 76.0, 76.0, 74.0, 75.0, 163.0, 74.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 84.0, 83.0, 84.0, 150.0, 83.0, 85.0, 137.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 146.0, 147.0, 146.0, 149.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 56.0, 55.0, 55.0, 55.0, 57.0, 55.0, 54.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 65.0, 63.0, 67.0, 62.0, 63.0, 62.0, 62.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 83.0, 80.0, 81.0, 79.0, 81.0, 80.0, 112.0, 81.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 135.0, 122.0, 121.0, 120.0, 141.0, 137.0, 146.0, 133.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 164.0, 173.0, 167.0, 166.0, 164.0, 167.0, 165.0, 162.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 64.0, 65.0, 64.0, 63.0, 63.0, 64.0], "value": 63.8, "unit": "score"}]}]} 17:16:56 INFO - Return code: 0 17:16:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:16:56 ERROR - # TBPL SUCCESS # 17:16:56 INFO - Running post-action listener: _resource_record_post_action 17:16:56 INFO - ##### 17:16:56 INFO - ##### Finished run-tests step (success) 17:16:56 INFO - ##### 17:16:56 INFO - Running post-run listener: _resource_record_post_run 17:16:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539725824; Read time: 104; Write time: 440288 17:16:57 INFO - TinderboxPrint: CPU usage
13.4% 17:16:57 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 17:16:57 INFO - TinderboxPrint: I/O write bytes / time
539,725,824 / 440,288 17:16:57 INFO - TinderboxPrint: CPU idle
8,213.3 (86.6%) 17:16:57 INFO - TinderboxPrint: CPU user
1,218.3 (12.8%) 17:16:57 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 249208832; Read time: 0; Write time: 250700 17:16:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290516992; Read time: 104; Write time: 189588 17:16:57 INFO - Running post-run listener: _upload_blobber_files 17:16:57 INFO - Blob upload gear active. 17:16:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:57 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 17:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:16:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:01 INFO - (blobuploader) - INFO - Done attempting. 17:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:02 INFO - (blobuploader) - INFO - Done attempting. 17:17:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:03 INFO - (blobuploader) - INFO - Done attempting. 17:17:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:17:03 INFO - Return code: 0 17:17:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:17:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:17:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8173439f85887429f3ad49b20e9a0240afaa9f79ccc417a25a0aea5c30608ac83af3152c3778543c90aede26de9b954137768b0c815b4cf77e295cedd36d234a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc171c210b39c84e9234f4d10d56606d78d153ec3a894ba3622c8513d36e64d5ead3b1577c67bb05068e9109bd59f443ece2a0b71de97b1339cdaa276be9c884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e70a3ed5118f9ad5762dadd287f710863c450cb793ef7375f7e095d5e4cb167c4ccdaf96f95335c0b71532ff6c1684ed33fdd028dc3c3f63074e0d6abd960b"} 17:17:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:17:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:17:03 INFO - Contents: 17:17:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8173439f85887429f3ad49b20e9a0240afaa9f79ccc417a25a0aea5c30608ac83af3152c3778543c90aede26de9b954137768b0c815b4cf77e295cedd36d234a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc171c210b39c84e9234f4d10d56606d78d153ec3a894ba3622c8513d36e64d5ead3b1577c67bb05068e9109bd59f443ece2a0b71de97b1339cdaa276be9c884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e70a3ed5118f9ad5762dadd287f710863c450cb793ef7375f7e095d5e4cb167c4ccdaf96f95335c0b71532ff6c1684ed33fdd028dc3c3f63074e0d6abd960b"} 17:17:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:17:03 INFO - Copying logs to upload dir... 17:17:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:17:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.314054 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-02 17:17:03.360810) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 17:17:03.364263) ========= 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=1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8173439f85887429f3ad49b20e9a0240afaa9f79ccc417a25a0aea5c30608ac83af3152c3778543c90aede26de9b954137768b0c815b4cf77e295cedd36d234a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc171c210b39c84e9234f4d10d56606d78d153ec3a894ba3622c8513d36e64d5ead3b1577c67bb05068e9109bd59f443ece2a0b71de97b1339cdaa276be9c884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e70a3ed5118f9ad5762dadd287f710863c450cb793ef7375f7e095d5e4cb167c4ccdaf96f95335c0b71532ff6c1684ed33fdd028dc3c3f63074e0d6abd960b"} build_url:https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011143 build_url: 'https://queue.taskcluster.net/v1/task/CP6W1QfjQYGO_9AmViwb9g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8173439f85887429f3ad49b20e9a0240afaa9f79ccc417a25a0aea5c30608ac83af3152c3778543c90aede26de9b954137768b0c815b4cf77e295cedd36d234a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc171c210b39c84e9234f4d10d56606d78d153ec3a894ba3622c8513d36e64d5ead3b1577c67bb05068e9109bd59f443ece2a0b71de97b1339cdaa276be9c884", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e70a3ed5118f9ad5762dadd287f710863c450cb793ef7375f7e095d5e4cb167c4ccdaf96f95335c0b71532ff6c1684ed33fdd028dc3c3f63074e0d6abd960b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 17:17:03.390109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 17:17:03.390418) ========= 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=1f5564757af27664ca02d71f000001b0-1464907792.964261-899738108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 17:17:03.472494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 17:17:03.472820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 17:17:03.473149) ========= ========= Total master_lag: 0.18 =========