builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1463541077.8 results: success (0) buildid: 20160517173008 builduid: 3c4665b7dfdc46799ff880124e08efe0 revision: 878623e95803fae913434e1d4bcd34e16645580d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:17.799918) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:17.800435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:17.800789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:17.819658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:17.819976) ========= 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=8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 20:11:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-05-17 20:11:18 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.267051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.109032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.109400) ========= 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=8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014886 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.160407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.161085) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 878623e95803fae913434e1d4bcd34e16645580d --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 878623e95803fae913434e1d4bcd34e16645580d --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=8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 20:11:18,297 truncating revision to first 12 chars 2016-05-17 20:11:18,297 Setting DEBUG logging. 2016-05-17 20:11:18,297 attempt 1/10 2016-05-17 20:11:18,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/878623e95803?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 20:11:18,572 unpacking tar archive at: fx-team-878623e95803/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.759888) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.760418) ========= script_repo_revision: 878623e95803fae913434e1d4bcd34e16645580d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.761109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.761450) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 20:11:18.772816) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-17 20:11:18.773342) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:11:18 INFO - MultiFileLogger online at 20160517 20:11:18 in /builds/slave/test 20:11:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:11:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:11:18 INFO - {'append_to_log': False, 20:11:18 INFO - 'base_work_dir': '/builds/slave/test', 20:11:18 INFO - 'blob_upload_branch': 'Fx-Team', 20:11:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:11:18 INFO - 'branch': 'Fx-Team', 20:11:18 INFO - 'buildbot_json_path': 'buildprops.json', 20:11:18 INFO - 'config_files': ('talos/linux_config.py',), 20:11:18 INFO - 'default_actions': ('clobber', 20:11:18 INFO - 'read-buildbot-config', 20:11:18 INFO - 'download-and-extract', 20:11:18 INFO - 'populate-webroot', 20:11:18 INFO - 'create-virtualenv', 20:11:18 INFO - 'install', 20:11:18 INFO - 'run-tests'), 20:11:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:11:18 INFO - 'download_minidump_stackwalk': True, 20:11:18 INFO - 'download_symbols': 'ondemand', 20:11:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:11:18 INFO - 'tooltool.py': '/tools/tooltool.py', 20:11:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:11:18 INFO - '/tools/misc-python/virtualenv.py')}, 20:11:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:11:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:11:18 INFO - 'installer_path': 'installer.exe', 20:11:18 INFO - 'log_level': 'info', 20:11:18 INFO - 'log_name': 'talos', 20:11:18 INFO - 'log_to_console': True, 20:11:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:11:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:11:18 INFO - 'opt_config_files': (), 20:11:18 INFO - 'pip_index': False, 20:11:18 INFO - 'sps_profile': False, 20:11:18 INFO - 'sps_profile_interval': 0, 20:11:18 INFO - 'suite': 'dromaeojs', 20:11:18 INFO - 'system_bits': '32', 20:11:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:11:18 INFO - 'title': 'talos-linux64-ix-038', 20:11:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:11:18 INFO - 'use_talos_json': True, 20:11:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:11:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:11:18 INFO - 'work_dir': 'build'} 20:11:18 INFO - ##### 20:11:18 INFO - ##### Running clobber step. 20:11:18 INFO - ##### 20:11:18 INFO - Running pre-action listener: _resource_record_pre_action 20:11:18 INFO - Running main action method: clobber 20:11:18 INFO - rmtree: /builds/slave/test/build 20:11:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:11:19 INFO - Running post-action listener: _resource_record_post_action 20:11:19 INFO - ##### 20:11:19 INFO - ##### Finished clobber step (success) 20:11:19 INFO - ##### 20:11:19 INFO - ##### 20:11:19 INFO - ##### Running read-buildbot-config step. 20:11:19 INFO - ##### 20:11:19 INFO - Running pre-action listener: _resource_record_pre_action 20:11:19 INFO - Running main action method: read_buildbot_config 20:11:19 INFO - Using buildbot properties: 20:11:19 INFO - { 20:11:19 INFO - "project": "", 20:11:19 INFO - "product": "firefox", 20:11:19 INFO - "script_repo_revision": "production", 20:11:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:11:19 INFO - "repository": "", 20:11:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:11:19 INFO - "buildid": "20160517173008", 20:11:19 INFO - "pgo_build": "True", 20:11:19 INFO - "basedir": "/builds/slave/test", 20:11:19 INFO - "buildnumber": 100, 20:11:19 INFO - "slavename": "talos-linux64-ix-038", 20:11:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:11:19 INFO - "platform": "ubuntu64_hw", 20:11:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:11:19 INFO - "branch": "fx-team", 20:11:19 INFO - "repo_path": "integration/fx-team", 20:11:19 INFO - "revision": "878623e95803fae913434e1d4bcd34e16645580d", 20:11:19 INFO - "stage_platform": "linux64-pgo", 20:11:19 INFO - "builduid": "3c4665b7dfdc46799ff880124e08efe0", 20:11:19 INFO - "slavebuilddir": "test" 20:11:19 INFO - } 20:11:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:11:19 INFO - Running post-action listener: _resource_record_post_action 20:11:19 INFO - ##### 20:11:19 INFO - ##### Finished read-buildbot-config step (success) 20:11:19 INFO - ##### 20:11:19 INFO - ##### 20:11:19 INFO - ##### Running download-and-extract step. 20:11:19 INFO - ##### 20:11:19 INFO - Running pre-action listener: _resource_record_pre_action 20:11:19 INFO - Running main action method: download_and_extract 20:11:19 INFO - mkdir: /builds/slave/test/build/tests 20:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:19 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:20 INFO - Downloaded 1361 bytes. 20:11:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:11:20 INFO - Using the following test package requirements: 20:11:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:11:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:11:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'jsshell-linux-x86_64.zip'], 20:11:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:11:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:11:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:11:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:11:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:11:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:11:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:11:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:20 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:21 INFO - Downloaded 24062848 bytes. 20:11:21 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'] 20:11:21 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 20:11:22 INFO - Return code: 0 20:11:22 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 20:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:22 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:24 INFO - Downloaded 24062848 bytes. 20:11:24 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'] 20:11:24 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 20:11:25 INFO - Return code: 0 20:11:25 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')]} 20:11:25 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:26 INFO - Downloaded 10840194 bytes. 20:11:26 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'] 20:11:26 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 20:11:26 INFO - Return code: 0 20:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:26 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/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 20:11:33 INFO - Downloaded 58395862 bytes. 20:11:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:33 INFO - mkdir: /builds/slave/test/properties 20:11:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:33 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:33 INFO - Contents: 20:11:33 INFO - build_url:https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:11:33 INFO - Running post-action listener: _resource_record_post_action 20:11:33 INFO - Running post-action listener: set_extra_try_arguments 20:11:33 INFO - ##### 20:11:33 INFO - ##### Finished download-and-extract step (success) 20:11:33 INFO - ##### 20:11:33 INFO - ##### 20:11:33 INFO - ##### Running populate-webroot step. 20:11:33 INFO - ##### 20:11:33 INFO - Running pre-action listener: _resource_record_pre_action 20:11:33 INFO - Running main action method: populate_webroot 20:11:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:33 INFO - '--tppagecycles', 20:11:33 INFO - '7'], 20:11:33 INFO - 'tests': ['tsvgm']}}, 20:11:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:11:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:11:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['damp', 'tps']}, 20:11:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'tests': ['damp', 'tps']}, 20:11:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['dromaeo_dom']}, 20:11:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['a11yr', 20:11:33 INFO - 'ts_paint', 20:11:33 INFO - 'tpaint', 20:11:33 INFO - 'sessionrestore', 20:11:33 INFO - 'sessionrestore_no_auto_restore', 20:11:33 INFO - 'tabpaint']}, 20:11:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:11:33 INFO - 'ts_paint', 20:11:33 INFO - 'tpaint', 20:11:33 INFO - 'sessionrestore', 20:11:33 INFO - 'sessionrestore_no_auto_restore', 20:11:33 INFO - 'tabpaint']}, 20:11:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:11:33 INFO - 'ts_paint', 20:11:33 INFO - 'tpaint', 20:11:33 INFO - 'sessionrestore', 20:11:33 INFO - 'sessionrestore_no_auto_restore', 20:11:33 INFO - 'tabpaint']}, 20:11:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:11:33 INFO - 'ts_paint', 20:11:33 INFO - 'tpaint', 20:11:33 INFO - 'sessionrestore', 20:11:33 INFO - 'sessionrestore_no_auto_restore', 20:11:33 INFO - 'tabpaint']}, 20:11:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['a11yr', 20:11:33 INFO - 'ts_paint', 20:11:33 INFO - 'tpaint', 20:11:33 INFO - 'sessionrestore', 20:11:33 INFO - 'sessionrestore_no_auto_restore', 20:11:33 INFO - 'tabpaint']}, 20:11:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['a11yr', 20:11:33 INFO - 'ts_paint', 20:11:33 INFO - 'tpaint', 20:11:33 INFO - 'sessionrestore', 20:11:33 INFO - 'sessionrestore_no_auto_restore', 20:11:33 INFO - 'tabpaint']}, 20:11:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['tsvgx', 20:11:33 INFO - 'tsvgr_opacity', 20:11:33 INFO - 'tart', 20:11:33 INFO - 'tscrollx', 20:11:33 INFO - 'cart']}, 20:11:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:11:33 INFO - 'tsvgr_opacity', 20:11:33 INFO - 'tart', 20:11:33 INFO - 'tscrollx', 20:11:33 INFO - 'cart']}, 20:11:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'talos_options': ['--disable-e10s'], 20:11:33 INFO - 'tests': ['tp5o']}, 20:11:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'tests': ['tp5o']}, 20:11:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'talos_options': ['--disable-e10s', 20:11:33 INFO - '--xperf_path', 20:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:33 INFO - 'tests': ['tp5n']}, 20:11:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:33 INFO - 'talos_options': ['--xperf_path', 20:11:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:33 INFO - 'tests': ['tp5n']}}, 20:11:33 INFO - 'talos.zip': {'path': '', 20:11:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:33 INFO - Running post-action listener: _resource_record_post_action 20:11:33 INFO - ##### 20:11:33 INFO - ##### Finished populate-webroot step (success) 20:11:33 INFO - ##### 20:11:33 INFO - ##### 20:11:33 INFO - ##### Running create-virtualenv step. 20:11:33 INFO - ##### 20:11:33 INFO - Running pre-action listener: _resource_record_pre_action 20:11:33 INFO - Running main action method: create_virtualenv 20:11:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:33 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 20:11:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:33 INFO - Using real prefix '/usr' 20:11:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:36 INFO - Installing pip.................done. 20:11:36 INFO - Return code: 0 20:11:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:11:36 INFO - Using env: {'DISPLAY': ':0', 20:11:36 INFO - 'HOME': '/home/cltbld', 20:11:36 INFO - 'LANG': 'en_US.UTF-8', 20:11:36 INFO - 'LANGUAGE': 'en_US:en', 20:11:36 INFO - 'LOGNAME': 'cltbld', 20:11:36 INFO - 'MAIL': '/var/mail/cltbld', 20:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:36 INFO - 'MOZ_NO_REMOTE': '1', 20:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:36 INFO - 'NO_EM_RESTART': '1', 20:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:36 INFO - 'PWD': '/builds/slave/test', 20:11:36 INFO - 'SHELL': '/bin/bash', 20:11:36 INFO - 'SHLVL': '1', 20:11:36 INFO - 'TERM': 'linux', 20:11:36 INFO - 'TMOUT': '86400', 20:11:36 INFO - 'USER': 'cltbld', 20:11:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:36 INFO - '_': '/tools/buildbot/bin/python'} 20:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:36 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 20:11:36 INFO - Cleaning up... 20:11:36 INFO - Return code: 0 20:11:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:11:36 INFO - Using env: {'DISPLAY': ':0', 20:11:36 INFO - 'HOME': '/home/cltbld', 20:11:36 INFO - 'LANG': 'en_US.UTF-8', 20:11:36 INFO - 'LANGUAGE': 'en_US:en', 20:11:36 INFO - 'LOGNAME': 'cltbld', 20:11:36 INFO - 'MAIL': '/var/mail/cltbld', 20:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:36 INFO - 'MOZ_NO_REMOTE': '1', 20:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:36 INFO - 'NO_EM_RESTART': '1', 20:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:36 INFO - 'PWD': '/builds/slave/test', 20:11:36 INFO - 'SHELL': '/bin/bash', 20:11:36 INFO - 'SHLVL': '1', 20:11:36 INFO - 'TERM': 'linux', 20:11:36 INFO - 'TMOUT': '86400', 20:11:36 INFO - 'USER': 'cltbld', 20:11:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:36 INFO - '_': '/tools/buildbot/bin/python'} 20:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:36 INFO - Downloading/unpacking psutil>=3.1.1 20:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:38 INFO - Installing collected packages: psutil 20:11:38 INFO - Running setup.py install for psutil 20:11:38 INFO - building 'psutil._psutil_linux' extension 20:11:38 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 20:11:39 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 20:11:39 INFO - building 'psutil._psutil_posix' extension 20:11:39 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 20:11:39 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 20:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:39 INFO - Successfully installed psutil 20:11:39 INFO - Cleaning up... 20:11:39 INFO - Return code: 0 20:11:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:11:39 INFO - Using env: {'DISPLAY': ':0', 20:11:39 INFO - 'HOME': '/home/cltbld', 20:11:39 INFO - 'LANG': 'en_US.UTF-8', 20:11:39 INFO - 'LANGUAGE': 'en_US:en', 20:11:39 INFO - 'LOGNAME': 'cltbld', 20:11:39 INFO - 'MAIL': '/var/mail/cltbld', 20:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:39 INFO - 'MOZ_NO_REMOTE': '1', 20:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:39 INFO - 'NO_EM_RESTART': '1', 20:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:39 INFO - 'PWD': '/builds/slave/test', 20:11:39 INFO - 'SHELL': '/bin/bash', 20:11:39 INFO - 'SHLVL': '1', 20:11:39 INFO - 'TERM': 'linux', 20:11:39 INFO - 'TMOUT': '86400', 20:11:39 INFO - 'USER': 'cltbld', 20:11:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:39 INFO - '_': '/tools/buildbot/bin/python'} 20:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:11:41 INFO - Installing collected packages: mozsystemmonitor 20:11:41 INFO - Running setup.py install for mozsystemmonitor 20:11:41 INFO - Successfully installed mozsystemmonitor 20:11:41 INFO - Cleaning up... 20:11:41 INFO - Return code: 0 20:11:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:41 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')]} 20:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:41 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')]} 20:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:41 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 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:41 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 20:11:41 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 20:11:41 INFO - Using env: {'DISPLAY': ':0', 20:11:41 INFO - 'HOME': '/home/cltbld', 20:11:41 INFO - 'LANG': 'en_US.UTF-8', 20:11:41 INFO - 'LANGUAGE': 'en_US:en', 20:11:41 INFO - 'LOGNAME': 'cltbld', 20:11:41 INFO - 'MAIL': '/var/mail/cltbld', 20:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:41 INFO - 'MOZ_NO_REMOTE': '1', 20:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:41 INFO - 'NO_EM_RESTART': '1', 20:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:41 INFO - 'PWD': '/builds/slave/test', 20:11:41 INFO - 'SHELL': '/bin/bash', 20:11:41 INFO - 'SHLVL': '1', 20:11:41 INFO - 'TERM': 'linux', 20:11:41 INFO - 'TMOUT': '86400', 20:11:41 INFO - 'USER': 'cltbld', 20:11:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:41 INFO - '_': '/tools/buildbot/bin/python'} 20:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:43 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 20:11:43 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 20:11:43 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 20:11:43 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 20:11:43 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 20:11:43 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 20:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:44 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 20:11:44 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 20:11:44 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 20:11:44 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 20:11:44 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 20:11:44 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 20:11:44 INFO - Downloading docopt-0.6.1.tar.gz 20:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:44 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:44 INFO - Running setup.py install for blobuploader 20:11:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:44 INFO - Running setup.py install for requests 20:11:44 INFO - Running setup.py install for docopt 20:11:44 INFO - Successfully installed blobuploader requests docopt 20:11:44 INFO - Cleaning up... 20:11:45 INFO - Return code: 0 20:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:45 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 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:45 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 20:11:45 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 20:11:45 INFO - Using env: {'DISPLAY': ':0', 20:11:45 INFO - 'HOME': '/home/cltbld', 20:11:45 INFO - 'LANG': 'en_US.UTF-8', 20:11:45 INFO - 'LANGUAGE': 'en_US:en', 20:11:45 INFO - 'LOGNAME': 'cltbld', 20:11:45 INFO - 'MAIL': '/var/mail/cltbld', 20:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:45 INFO - 'MOZ_NO_REMOTE': '1', 20:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:45 INFO - 'NO_EM_RESTART': '1', 20:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:45 INFO - 'PWD': '/builds/slave/test', 20:11:45 INFO - 'SHELL': '/bin/bash', 20:11:45 INFO - 'SHLVL': '1', 20:11:45 INFO - 'TERM': 'linux', 20:11:45 INFO - 'TMOUT': '86400', 20:11:45 INFO - 'USER': 'cltbld', 20:11:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:45 INFO - '_': '/tools/buildbot/bin/python'} 20:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:45 INFO - Running setup.py (path:/tmp/pip-jmRlcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:45 INFO - Running setup.py (path:/tmp/pip-Sidp4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:45 INFO - Running setup.py (path:/tmp/pip-pX15Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:45 INFO - Running setup.py (path:/tmp/pip-qlIFUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:45 INFO - Running setup.py (path:/tmp/pip-TM_trQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:45 INFO - Running setup.py (path:/tmp/pip-_hwqiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:45 INFO - Running setup.py (path:/tmp/pip-YTz7FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:45 INFO - Running setup.py (path:/tmp/pip-gyTPd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:45 INFO - Running setup.py (path:/tmp/pip-ZLgOmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:45 INFO - Running setup.py (path:/tmp/pip-Ym9IJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:45 INFO - Running setup.py (path:/tmp/pip-M4t5aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:46 INFO - Running setup.py (path:/tmp/pip-pSYalL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:46 INFO - Running setup.py (path:/tmp/pip-1FON4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:46 INFO - Running setup.py (path:/tmp/pip-uVbvgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:46 INFO - Running setup.py (path:/tmp/pip-_130k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:46 INFO - Running setup.py (path:/tmp/pip-NeBFXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:46 INFO - Running setup.py (path:/tmp/pip-fW0QFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:46 INFO - Running setup.py install for manifestparser 20:11:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:46 INFO - Running setup.py install for mozcrash 20:11:46 INFO - Running setup.py install for mozdebug 20:11:46 INFO - Running setup.py install for mozdevice 20:11:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:46 INFO - Running setup.py install for mozfile 20:11:46 INFO - Running setup.py install for mozhttpd 20:11:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Running setup.py install for mozinfo 20:11:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Running setup.py install for mozInstall 20:11:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Running setup.py install for mozleak 20:11:47 INFO - Running setup.py install for mozlog 20:11:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Running setup.py install for moznetwork 20:11:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Running setup.py install for mozprocess 20:11:47 INFO - Running setup.py install for mozprofile 20:11:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:47 INFO - Running setup.py install for mozrunner 20:11:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:48 INFO - Running setup.py install for mozscreenshot 20:11:48 INFO - Running setup.py install for moztest 20:11:48 INFO - Running setup.py install for mozversion 20:11:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:48 INFO - Cleaning up... 20:11:48 INFO - Return code: 0 20:11:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:48 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 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:48 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 20:11:48 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 20:11:48 INFO - Using env: {'DISPLAY': ':0', 20:11:48 INFO - 'HOME': '/home/cltbld', 20:11:48 INFO - 'LANG': 'en_US.UTF-8', 20:11:48 INFO - 'LANGUAGE': 'en_US:en', 20:11:48 INFO - 'LOGNAME': 'cltbld', 20:11:48 INFO - 'MAIL': '/var/mail/cltbld', 20:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:48 INFO - 'MOZ_NO_REMOTE': '1', 20:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:48 INFO - 'NO_EM_RESTART': '1', 20:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:48 INFO - 'PWD': '/builds/slave/test', 20:11:48 INFO - 'SHELL': '/bin/bash', 20:11:48 INFO - 'SHLVL': '1', 20:11:48 INFO - 'TERM': 'linux', 20:11:48 INFO - 'TMOUT': '86400', 20:11:48 INFO - 'USER': 'cltbld', 20:11:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:48 INFO - '_': '/tools/buildbot/bin/python'} 20:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:50 INFO - Running setup.py (path:/tmp/pip-GsJ1eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:50 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)) 20:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:50 INFO - Running setup.py (path:/tmp/pip-pLwJfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:50 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)) 20:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:50 INFO - Running setup.py (path:/tmp/pip-fl2PBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:50 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)) 20:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:50 INFO - Running setup.py (path:/tmp/pip-2SjqvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:50 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)) 20:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:50 INFO - Running setup.py (path:/tmp/pip-Its7xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:50 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)) 20:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:50 INFO - Running setup.py (path:/tmp/pip-JS6OG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:51 INFO - Running setup.py (path:/tmp/pip-HjyLZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:51 INFO - Running setup.py (path:/tmp/pip-KbEUKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:51 INFO - Running setup.py (path:/tmp/pip-kO4HKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:51 INFO - Running setup.py (path:/tmp/pip-g_gw5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:51 INFO - Running setup.py (path:/tmp/pip-jTNj8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:51 INFO - Running setup.py (path:/tmp/pip-3fBt4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:51 INFO - Running setup.py (path:/tmp/pip-YOdF_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:51 INFO - Running setup.py (path:/tmp/pip-l3rizh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:51 INFO - Running setup.py (path:/tmp/pip-asSXW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:51 INFO - Running setup.py (path:/tmp/pip-BFRdo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:51 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)) 20:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:51 INFO - Running setup.py (path:/tmp/pip-PhpgKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:51 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)) 20:11:51 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)) 20:11:51 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)) 20:11:51 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)) 20:11:51 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)) 20:11:51 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)) 20:11:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:53 INFO - Downloading blessings-1.6.tar.gz 20:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:53 INFO - Installing collected packages: blessings 20:11:53 INFO - Running setup.py install for blessings 20:11:57 INFO - Successfully installed blessings 20:11:57 INFO - Cleaning up... 20:11:57 INFO - Return code: 0 20:11:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:57 INFO - Reading from file tmpfile_stdout 20:11:57 INFO - Current package versions: 20:11:57 INFO - argparse == 1.2.1 20:11:57 INFO - blessings == 1.6 20:11:57 INFO - blobuploader == 1.2.4 20:11:57 INFO - docopt == 0.6.1 20:11:57 INFO - manifestparser == 1.1 20:11:57 INFO - mozInstall == 1.12 20:11:57 INFO - mozcrash == 0.17 20:11:57 INFO - mozdebug == 0.1 20:11:57 INFO - mozdevice == 0.48 20:11:57 INFO - mozfile == 1.2 20:11:57 INFO - mozhttpd == 0.7 20:11:57 INFO - mozinfo == 0.9 20:11:57 INFO - mozleak == 0.1 20:11:57 INFO - mozlog == 3.2 20:11:57 INFO - moznetwork == 0.27 20:11:57 INFO - mozprocess == 0.22 20:11:57 INFO - mozprofile == 0.28 20:11:57 INFO - mozrunner == 6.11 20:11:57 INFO - mozscreenshot == 0.1 20:11:57 INFO - mozsystemmonitor == 0.3 20:11:57 INFO - moztest == 0.7 20:11:57 INFO - mozversion == 1.4 20:11:57 INFO - psutil == 3.1.1 20:11:57 INFO - requests == 1.2.3 20:11:57 INFO - wsgiref == 0.1.2 20:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:57 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 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:57 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 20:11:57 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 20:11:57 INFO - Using env: {'DISPLAY': ':0', 20:11:57 INFO - 'HOME': '/home/cltbld', 20:11:57 INFO - 'LANG': 'en_US.UTF-8', 20:11:57 INFO - 'LANGUAGE': 'en_US:en', 20:11:57 INFO - 'LOGNAME': 'cltbld', 20:11:57 INFO - 'MAIL': '/var/mail/cltbld', 20:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:57 INFO - 'MOZ_NO_REMOTE': '1', 20:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:57 INFO - 'NO_EM_RESTART': '1', 20:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:57 INFO - 'PWD': '/builds/slave/test', 20:11:57 INFO - 'SHELL': '/bin/bash', 20:11:57 INFO - 'SHLVL': '1', 20:11:57 INFO - 'TERM': 'linux', 20:11:57 INFO - 'TMOUT': '86400', 20:11:57 INFO - 'USER': 'cltbld', 20:11:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:57 INFO - '_': '/tools/buildbot/bin/python'} 20:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 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)) 20:11:57 INFO - Cleaning up... 20:11:57 INFO - Return code: 0 20:11:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:57 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 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:11:57 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 20:11:57 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 20:11:57 INFO - Using env: {'DISPLAY': ':0', 20:11:57 INFO - 'HOME': '/home/cltbld', 20:11:57 INFO - 'LANG': 'en_US.UTF-8', 20:11:57 INFO - 'LANGUAGE': 'en_US:en', 20:11:57 INFO - 'LOGNAME': 'cltbld', 20:11:57 INFO - 'MAIL': '/var/mail/cltbld', 20:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:57 INFO - 'MOZ_NO_REMOTE': '1', 20:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:57 INFO - 'NO_EM_RESTART': '1', 20:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:57 INFO - 'PWD': '/builds/slave/test', 20:11:57 INFO - 'SHELL': '/bin/bash', 20:11:57 INFO - 'SHLVL': '1', 20:11:57 INFO - 'TERM': 'linux', 20:11:57 INFO - 'TMOUT': '86400', 20:11:57 INFO - 'USER': 'cltbld', 20:11:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:57 INFO - '_': '/tools/buildbot/bin/python'} 20:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:57 INFO - Downloading/unpacking jsonschema 20:11:57 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 20:11:57 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 20:11:57 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 20:11:57 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 20:11:57 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 20:11:57 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 20:12:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:12:02 INFO - Downloading/unpacking functools32 (from jsonschema) 20:12:02 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 20:12:02 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 20:12:02 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 20:12:02 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 20:12:02 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 20:12:02 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 20:12:02 INFO - Downloading functools32-3.2.3-2.tar.gz 20:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:12:02 INFO - warning: no files found matching '*.txt' 20:12:02 INFO - no previously-included directories found matching 'build' 20:12:02 INFO - no previously-included directories found matching 'dist' 20:12:02 INFO - no previously-included directories found matching '.git*' 20:12:02 INFO - Installing collected packages: jsonschema, functools32 20:12:02 INFO - Running setup.py install for functools32 20:12:02 INFO - warning: no files found matching '*.txt' 20:12:02 INFO - no previously-included directories found matching 'build' 20:12:02 INFO - no previously-included directories found matching 'dist' 20:12:02 INFO - no previously-included directories found matching '.git*' 20:12:02 INFO - Successfully installed jsonschema functools32 20:12:02 INFO - Cleaning up... 20:12:02 INFO - Return code: 0 20:12:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:12:02 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')]} 20:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:02 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')]} 20:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:02 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 0x7f1935824f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1122770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, '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': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', '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 20:12:02 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 20:12:02 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 20:12:02 INFO - Using env: {'DISPLAY': ':0', 20:12:02 INFO - 'HOME': '/home/cltbld', 20:12:02 INFO - 'LANG': 'en_US.UTF-8', 20:12:02 INFO - 'LANGUAGE': 'en_US:en', 20:12:02 INFO - 'LOGNAME': 'cltbld', 20:12:02 INFO - 'MAIL': '/var/mail/cltbld', 20:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:02 INFO - 'MOZ_NO_REMOTE': '1', 20:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:02 INFO - 'NO_EM_RESTART': '1', 20:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:02 INFO - 'PWD': '/builds/slave/test', 20:12:02 INFO - 'SHELL': '/bin/bash', 20:12:02 INFO - 'SHLVL': '1', 20:12:02 INFO - 'TERM': 'linux', 20:12:02 INFO - 'TMOUT': '86400', 20:12:02 INFO - 'USER': 'cltbld', 20:12:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:02 INFO - '_': '/tools/buildbot/bin/python'} 20:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:03 INFO - Downloading/unpacking flake8 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12: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 20:12:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:12:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:12:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 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 20:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:05 INFO - no previously-included directories found matching 'docs/_build' 20:12:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:12:05 INFO - Running setup.py install for pep8 20:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:05 INFO - no previously-included directories found matching 'docs/_build' 20:12:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:12:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:12:05 INFO - Cleaning up... 20:12:06 INFO - Return code: 0 20:12:06 INFO - Running post-action listener: _resource_record_post_action 20:12:06 INFO - Running post-action listener: _start_resource_monitoring 20:12:06 INFO - Starting resource monitoring. 20:12:06 INFO - ##### 20:12:06 INFO - ##### Finished create-virtualenv step (success) 20:12:06 INFO - ##### 20:12:06 INFO - ##### 20:12:06 INFO - ##### Running install step. 20:12:06 INFO - ##### 20:12:06 INFO - Running pre-action listener: _resource_record_pre_action 20:12:06 INFO - Running main action method: install 20:12:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:06 INFO - Reading from file tmpfile_stdout 20:12:06 INFO - Detecting whether we're running mozinstall >=1.0... 20:12:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:12:06 INFO - Reading from file tmpfile_stdout 20:12:06 INFO - Output received: 20:12:06 INFO - Usage: mozinstall [options] installer 20:12:06 INFO - Options: 20:12:06 INFO - -h, --help show this help message and exit 20:12:06 INFO - -d DEST, --destination=DEST 20:12:06 INFO - Directory to install application into. [default: 20:12:06 INFO - "/builds/slave/test"] 20:12:06 INFO - --app=APP Application being installed. [default: firefox] 20:12:06 INFO - mkdir: /builds/slave/test/build/application 20:12:06 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'] 20:12:06 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 20:12:22 INFO - Reading from file tmpfile_stdout 20:12:22 INFO - Output received: 20:12:22 INFO - /builds/slave/test/build/application/firefox/firefox 20:12:22 INFO - Running post-action listener: _resource_record_post_action 20:12:22 INFO - ##### 20:12:22 INFO - ##### Finished install step (success) 20:12:22 INFO - ##### 20:12:22 INFO - ##### 20:12:22 INFO - ##### Running run-tests step. 20:12:22 INFO - ##### 20:12:22 INFO - Running pre-action listener: _resource_record_pre_action 20:12:22 INFO - Running main action method: run_tests 20:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:12:22 INFO - Python 2.7.3 20:12:22 INFO - Return code: 0 20:12:22 INFO - grabbing minidump binary from tooltool 20:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:22 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 0x11b19c0>, '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 0x11b28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:12:22 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 20:12:22 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 20:12:22 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 20:12:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:12:22 INFO - Return code: 0 20:12:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:12:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:12:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:12:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:12:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:12:23 INFO - Return code: 0 20:12:23 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:12:23 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:12:23 INFO - Using env: {'DISPLAY': ':0', 20:12:23 INFO - 'HOME': '/home/cltbld', 20:12:23 INFO - 'LANG': 'en_US.UTF-8', 20:12:23 INFO - 'LANGUAGE': 'en_US:en', 20:12:23 INFO - 'LOGNAME': 'cltbld', 20:12:23 INFO - 'MAIL': '/var/mail/cltbld', 20:12:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:12:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:23 INFO - 'MOZ_NO_REMOTE': '1', 20:12:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:23 INFO - 'NO_EM_RESTART': '1', 20:12:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:23 INFO - 'PWD': '/builds/slave/test', 20:12:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:12:23 INFO - 'SHELL': '/bin/bash', 20:12:23 INFO - 'SHLVL': '1', 20:12:23 INFO - 'TERM': 'linux', 20:12:23 INFO - 'TMOUT': '86400', 20:12:23 INFO - 'USER': 'cltbld', 20:12:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535', 20:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:23 INFO - '_': '/tools/buildbot/bin/python'} 20:12:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:12:24 INFO - mozversion application_buildid: 20160517173008 20:12:24 INFO - mozversion application_changeset: 878623e95803fae913434e1d4bcd34e16645580d 20:12:24 INFO - mozversion application_display_name: Nightly 20:12:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:12:24 INFO - mozversion application_name: Firefox 20:12:24 INFO - mozversion application_remotingname: firefox 20:12:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:12:24 INFO - mozversion application_vendor: Mozilla 20:12:24 INFO - mozversion application_version: 49.0a1 20:12:24 INFO - mozversion platform_buildid: 20160517173008 20:12:24 INFO - mozversion platform_changeset: 878623e95803fae913434e1d4bcd34e16645580d 20:12:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:12:24 INFO - mozversion platform_version: 49.0a1 20:12:24 INFO - using testdate: 1463541144 20:12:24 INFO - actual date: 1463541144 20:12:24 INFO - starting webserver on 'localhost:36728' 20:12:24 INFO - SUITE-START | Running 2 tests 20:12:24 INFO - TEST-START | dromaeo_css 20:12:24 INFO - operating with platform_type : linux_ 20:12:24 INFO - Initialising browser for dromaeo_css test... 20:12:24 INFO - TEST-INFO | started process 9934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9fAT1/profile http://localhost:36728/getInfo.html) 20:12:29 INFO - PROCESS | 9934 | __metrics Screen width/height:1600/1200 20:12:29 INFO - PROCESS | 9934 | colorDepth:24 20:12:29 INFO - PROCESS | 9934 | Browser inner width/height: 1024/697 20:12:29 INFO - PROCESS | 9934 | __metrics 20:12:30 ERROR - PROCESS | 9934 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:12:31 INFO - TEST-INFO | 9934: exit 0 20:12:31 INFO - Browser initialized. 20:12:31 INFO - Running cycle 1/1 for dromaeo_css test... 20:12:31 INFO - TEST-INFO | started process 10016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9fAT1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:43 INFO - PROCESS | 10016 | RSS: Main: 152432640 20:12:43 INFO - PROCESS | 10016 | 20:13:34 INFO - PROCESS | 10016 | 1463541214648 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] 20:15:43 INFO - PROCESS | 10016 | Cycle 1(1): loaded http://localhost:36728/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36728/tests/dromaeo/cssquery-ext.html) 20:15:44 INFO - PROCESS | 10016 | RSS: Main: 260751360 20:15:44 INFO - PROCESS | 10016 | 20:18:46 INFO - PROCESS | 10016 | Cycle 1(1): loaded http://localhost:36728/tests/dromaeo/cssquery-ext.html (next: http://localhost:36728/tests/dromaeo/cssquery-jquery.html) 20:18:46 INFO - PROCESS | 10016 | RSS: Main: 234745856 20:18:46 INFO - PROCESS | 10016 | 20:21:48 INFO - PROCESS | 10016 | Cycle 1(1): loaded http://localhost:36728/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36728/tests/dromaeo/cssquery-mootools.html) 20:21:49 INFO - PROCESS | 10016 | RSS: Main: 227893248 20:21:49 INFO - PROCESS | 10016 | 20:24:51 INFO - PROCESS | 10016 | Cycle 1(1): loaded http://localhost:36728/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36728/tests/dromaeo/cssquery-prototype.html) 20:24:52 INFO - PROCESS | 10016 | RSS: Main: 228208640 20:24:52 INFO - PROCESS | 10016 | 20:27:54 INFO - PROCESS | 10016 | Cycle 1(1): loaded http://localhost:36728/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36728/tests/dromaeo/cssquery-yui.html) 20:27:55 INFO - PROCESS | 10016 | RSS: Main: 197935104 20:27:55 INFO - PROCESS | 10016 | 20:30:57 INFO - PROCESS | 10016 | Cycle 1(1): loaded http://localhost:36728/tests/dromaeo/cssquery-yui.html (next: http://localhost:36728/tests/dromaeo/cssquery-dojo.html) 20:30:58 INFO - PROCESS | 10016 | RSS: Main: 272371712 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | __start_tp_report 20:30:58 INFO - PROCESS | 10016 | _x_x_mozilla_page_load 20:30:58 INFO - PROCESS | 10016 | _x_x_mozilla_page_load_details 20:30:58 INFO - PROCESS | 10016 | |i|pagename|runs| 20:30:58 INFO - PROCESS | 10016 | |0;dojo.html;3123.8750449982;3126.4997600383945;3150.3384289299247;3171.5401266816325;3183.0928185467146;5317.521423071923;5331.173668081444;5385.838424847256;5393;5408.837734867955;5407.648502847322;5421.593380496469;5426.2674538937235;5449;5450.700211488366;4866.2943873138465;4874.951250487503;4967.875803104916;5010.323606313137;5034.1945288753805;4953.182724850395;4972.925406118911;5015.348004759395;5016.548510634042;5026.472220416858;4805.663603547753;4842.467328593852;4854.660173787836;4889.3888263967;4975.502449755014;4848.2727590861305;4864.075825593161;4914.385701787277;4924.482929292409;4966.652334336598;4851.296561998491;4875;4899.412070551521;4911.45973942866;4945.8268960586565;5215.269862219292;5347.839564813062;5365.436629153961;5415.025295446818;5429.429909859447;5811.970940145272;5819.88360232793;5840.240768700041;5842.006858834008;5854.414558544154;5710.571707121982;5789.131630255453;5803.53571714266;5817.621854579481;5827.708614569297;5534.418886016951;5557.47204015626;5557.916631250535;5559.527440167591;5560.888782224373;6041;6049.758009679564;6051.727672254759;6052.213212282375;6052.364501727256;5557.277553918046;5635.605507614428;5696.743646535916;5706.457886500776;5808.593398462067;5816.127580862904;5818.912716309259;5827.271591051119;5860.912086318709;5864.794732184353;5793.797217097382;5794.275715535558;5799.39106393831;5800.1589769484035;5802.564807639444;5596.300462442195;5784.739686714108;5871.6770577618645;5889.057750759944;5919.496842768327;4470.6870519064005;4476.104779044139;4476.2837945928495;4479.10417916418;4514.774261286922;3861.710371722132;3948.407738839197;3993.1414745829784;4016.2369149861433;4043.6765058795227;5421.26812880264;5437.592180586472;5439.428859969726;5460.645058071213;5508.14623733322;5756.740946657411;5768.451997060272;5788;5797.101449275369;5797.855053623609;5380.865478363072;5471.398146203915;5473.863153421196;5481.972590137104;5484.890302193934;5028.472010438924;5039.77321020555;5049.7727602257255;5059.064073146406;5082.974585127125;6020.729067191899;6022;6026.487748541423;6028.517718582503;6030.366811484819;5730.283714535683;5741.224934633771;5783.595148339576;5881.911771323348;5888.94111058901;5935.2877654681715;5942.7920022799;5944.851378715567;5955.642661440327;5984.640921544721;5713.428657134254;5730.770769169187;5731.283589551306;5731.971340143273;5734.05388110957;5651.858703532444;5780.393058728773;5793.217915581343;5812.505936995233;5821.76712931478;5695.658260504383;5727.770889164387;5740.68426236561;5743.282089738783;5745.597808153389;5694.971525142348;5722.227499287709;5733.082706767064;5745.6552606843725;5749.195112684144;5449.073657478159;5460.863478413072;5470.097433923358;5514.503694667499;5542.889142217053;5676.772929082956;5695.117256825199;5758.4817366435545;5768.94231057684;5769.307683078057;5442.156465747816;5582.16267559853;5590.832275031756;5594.356648985418;5621.943780562142 20:30:58 INFO - PROCESS | 10016 | |1;ext.html;592.2744637818672;633.6989929783354;634.7461015593764;648.8961766117422;655.3544758412966;42026.78986605066;43500.78249608748;43510.129797404035;43587.78206108969;46624.300635490494;45349.77325113378;45832.77083614586;45870.08259834801;45920.31119533201;46007.76996115023;8785.38502304839;8919.910800891972;8921.910780892173;8927.37508374414;8933.240674542672;8735.126487351246;8815.691450799224;8820.603072861737;8833.867491987625;8833.911660883405;8882.067382924797;8925.018247992715;8932.687355942544;8963.551822408854;8966.417182883124;8798.604062817189;8893.955530222373;8898.332625053083;8899.110088991114;8904.020557738644;8648.783780405478;8701.47791132534;8707.695230666895;8715.302775777986;8720.52037137957;40902.38646420306;41464.792676036726;41475;41502.169956601;41608.58391416108;3444.3800115979116;3549.378858699717;3560.4481305397703;3778.792166430845;4497.617702495292;32194.517082243787;32509.51235731466;32545.6745432545;32576.185595360068;32702;4379.715318504287;4432.335149727534;4438.15675021748;4444.111177764427;4462.620677242438;339306;340191;341130;341598;342142.28928855446;57194;57498.42501574931;57641;57727.71136144376;57781.711091444275;46284.07431851344;58372.70813645905;61071.08393374103;61083;61236.387636123065;13350.799738003938;13632.863671363359;13694.589162325146;13751.106178098391;13812.1022133561;11627.186096973131;11630.825537616942;11638.06895448362;11681.941590291994;11794.410279485992;14503.202323872289;15397.384104635914;15837.841621583868;15967.840321596868;16223.728677985091;6670.166229221348;6826.419754320938;6830.829229269308;6908.5509441886115;6915.654217289115;999.6351331763999;1103.8730545987314;1142.2404101272562;1155.2721785275392;1256.2399748152418;31866.20334491656;33075.173120671694;33128.66871331256;33150;33301.3339733204;1133.6939026462808;1151.3494875395374;1171.344047333496;1207.6980754811298;1217.8538575371012;17207.311707531808;17289;17352.47942561725;17419.47741567755;17503.73744393835;472910;475291;475313;477831.8867245271;479552;57142.7142864283;57533;57647.71176144092;57758.7112064437;57761.422385776445;1363.9429442182388;1366.9931650341684;1393.2197969137314;1396.1274203622736;1402.2778269191374;31105.68894311028;31669.208269792518;31852.522212166372;32208.83895580507;32624.34751304913;49316.50683493119;49333.75333123455;49402.50597493979;49635.503644963086;49745.25382119199;394386;405217;405553;406074;407269;35049;35545.46681799827;40246.79876600715;40536.79731601323;40968.38547421731;46511.53488465072;47552;47919;48529.514704852496;48632.51367486421;38540.80729596446;41075.178496430504;41100.47799342224;41606.1678766429;41691.58308416877;40014.39978400268;40290.597094028686;41136.38295425511;41492;41728.791356043024;40161.799191003855;40759.38860917148;41734;41773;41853.95365115896;34552.82723586366;36290;36587.451188231666;37035.07412314714;37221.6277837229;27961.440771184054;28202.576961345185;28278.15165545037;28461.630005752126;28969.69636366411 20:30:58 INFO - PROCESS | 10016 | |2;jquery.html;378.93365700583206;379.4933763425826;397.3324814311957;401.7328476563086;415.09923466078624;14319.433516915813;16752.748708769348;18029;19623.803761962376;19655.803441965578;13704.72590548191;16495.587610309747;17176.39882604109;17269.309227630878;17963.19165637546;5619.915701264485;5803.738831752581;5866.794662186824;5880.3237627672725;5881.176635271066;4149.958500414988;5760.798372056979;5802.071668533035;6111.663858487781;6410.423061924426;6416.839579010515;6431.6784160792;6461.321561236073;6481.157449531554;6482.837929051764;6290.811275661737;6306.49548036156;6442.452391546724;6449.645269510175;6469.256035555877;5470.070088084995;5687.658740475544;5696.829095127153;5700.144978253254;5744.167095771089;21799.237026703988;22319;22357.552848943094;22448.21431249915;22469.213577524708;2416.299273210784;2503.048841440241;2583.8191326607143;2832.830030198195;2853.1868417500914;9405.623775048989;13643.658908527366;14212.50256241037;14317.140971541638;14765.33555989983;1940.417874637603;1968.8523360748002;2003.4089943466713;2019.4648418169197;2068.586282743457;77400.61299693465;77959.61020194863;78791.60604196943;79727;80927.5953620234;10176.949115254525;10669.413182274895;11211.66365009051;11255.943720281346;11335.886641133648;15561.766573501407;15627.921860390625;15647.921760391126;15662.765058524132;15671.373145074069;7545.283198096172;7718.343940764986;7745.419093568005;7811.179826118289;7931.167227441036;6280.685965701788;7328.487005909536;7408.185099639036;7522.548647081193;7545.622718864035;4527.886802829889;4744.430668319824;4828.5412885775795;4860.6111511079025;4870.853874383774;1942.2716481319505;1946.464722201406;1977.0707767349322;1992.601479704065;2047.7952204779403;1013.7566983923805;1065.5950738719391;1067.6209945469247;1072.035168348477;1086.5219303506433;18950.24199032051;19354.516137096685;19503.122359493856;19511.317103901296;19554.511137221398;1041.2971244409994;1041.9895801041891;1054.99472502637;1069.5935544493043;1075.3977772447297;10231.43727095017;10521.84217236742;10687.73280667974;10807.67576972692;10809.67570972872;497184;500283;508395;511386;515020;91965.54017229872;95020.52489737507;95660;96762.19612783285;98309.50845245727;1018.1905385218917;1032.6437379104198;1053.8261186904228;1055.9524821383056;1058.4284486377271;16704.164791760606;16944.57638559046;16952.66094678075;17134.314627414762;17585.29658813633;40328.39507407333;40346.79826600848;40492;40716.38925416062;41039.1792164161;55803.44196557983;58060.709696451246;58723.70638146782;59721.70139149277;61042.08436873539;8251;8366.498010119412;8549.187827156411;8724;8874.156955089256;11196.83204751913;13260.336983150997;13321.467141314239;13439.46242150303;13498.662533436349;11333.546658133911;11608.593699220486;11755.235909665844;12221.083418743452;12310.138290319592;11547.595834145764;11557.017653499546;11596.47815848272;11867.287962721919;12078.939605301917;11845.5716578103;12100.45547950362;12130.696732581757;12305.815412768994;12536.310502922426;7373.225811289737;7696.499727517694;7749.883751743616;8529.74410767678;8665.523396213268;8819.955900220459;10780.622678206226;11167.888321116685;11915.94042029819;11986 20:30:58 INFO - PROCESS | 10016 | |3;mootools.html;1366.4807373198196;1507.8416766239548;1559.4230134850106;1687.2660392729165;1872.8033556476569;8450.91549084509;8688.47869127852;8698.043215246318;9044.638214471413;9059.229965452945;8744.125587441253;8920.643174273022;8930.955345223281;8955.552222388887;8966.0585638508;2032.573159636478;2293.805026572735;2335.9065637374483;2342.227065068523;2368.4789346343864;2261.7625149359246;2264.920727774528;2276.2488378834946;2276.408133885185;2280.8175345972363;2326.4300246439648;2375.95248095038;2378.2746262389965;2379.4884099918513;2380;1926.3354142820774;2255.5263394687217;2304.7580004099664;2314.5486630107134;2331.985586269978;2281.2927992322434;2290.919817806369;2296.391456264075;2297.517521320508;2311.8150547956125;8977.685780997634;9009.549522523914;9017.639294428214;9038.457692538468;9042.954785226031;5140.33175687162;5270.262163297141;5278.392984806758;5280.867978300535;5294.682319060868;3396.2698019925833;3522.3131489359585;3528.788272703646;3528.8764893228613;3576.409892367756;1134.6766171641043;1146.776378606172;1150.8388825564427;1151.027381862325;1186.3119390753343;12211.938940305241;12292.262464252173;12306.07704422172;12328.691782705415;12335.568255111119;4521.208788462071;4557;4637.7449240291435;4658.34783130362;4660.347551342815;9768.951155244178;9792.55933482995;9811.31320807551;9822.066903644143;9843.310968232156;4586.862394128181;5230.189320655304;5233.084210263189;5285;5286.788528458896;4766.976165119152;4865.464798872121;4874.415070191529;4924.162892308316;4973.980334031515;3760.0787806987464;3795.6394142556414;3796.088938654703;3870.806459677005;3923.843046278117;1160.4197901049474;1161.2219812725493;1169.5497233565138;1180.1738782852037;1181.1554738362113;1005.0401866217891;1007.0885848307294;1024.6721049264313;1029.5984566019258;1042.4110377636762;6134.110553969649;6139.201903752483;6236.251649802053;6326.746930122744;6356.078368636522;411.51646814992864;417.87046015735217;417.9080602267496;419.5950907374398;420.5626148805208;4212.620864122244;4261.765602891809;4311.116221174651;4325.437693099877;4330.2638551446325;10893.782124357469;11216.719582010515;11290.322580645188;11306.660800175843;11337.43312834355;10604.416757078281;11138.3873886937;11165;11219.775604487864;11220.214584978972;7889.6844126235455;8286.129956354496;8326.50040997542;8360;8372.246497815104;6142.662153581596;6196.938030619636;6319.715612797343;6375.6174629522375;6485.416312531895;10151.187904967732;10269.897301026895;10295.227857910537;10408.167346612405;10419;10396.896031039592;10397.532111055172;10420.739481513023;10681.946590266998;10833.29583577065;7139.678714457966;7353.5955522446775;7361;7810.726624568113;7921.881171782313;8164.387670924586;8359.707410240855;8499.702510412106;8527.275181609633;8882.467051976902;7494.850102998019;7609.201033891583;7961.960190199012;8044.2760151586635;8078.23256790604;7687.961560192163;7775.22247775218;7791.259830316111;7879.369650428067;7935.1668074853615;7373.262673732584;7404.777856664308;7467.58928258951;7485.401167906663;7486.288802563748;5290.312259406252;5346.331708536433;5414.945850541444;5473.781048758165;5513.476219759116;5432.809851655173;5467;5478.753456094565;5491.066518691752;5577.386487486455 20:30:58 INFO - PROCESS | 10016 | |4;prototype.html;305.55846801372024;309.83269034721235;310.4443046945966;311.92669722615193;312.45944515987344;5395.919061214085;5448.046591846426;5453.509184173424;5456.836294911149;5470.589705772063;5344.946550534493;5363.6245462817615;5397.892042159155;5403.108487099624;5420.5934554908445;3988.5612582615963;4012.6589239914642;4161.813883043334;4191.748495090289;4194.748315101088;4099.672026237894;4138.193052354792;4155.33514637658;4159.459270294858;4191.9939214588585;3928.607139286077;4138.213739389522;4145.813438395265;4149.336106223005;4172.102997855461;4035.2938235808765;4108.650764685005;4110.630043296118;4112.717441819789;4116.629503344683;3583.552055993001;3588.65907738767;3601.873934412283;3602.9279414411826;3609.657082577151;5161.303224064778;5197.688138711689;5201.219817027439;5210.531052205281;5220.138677118271;4546.795394207269;4689.812407503696;4703.294505824119;4714.339992401066;4731.574158325767;5492.47821456961;5496.697681627509;5511.5039646432015;5524.640898341635;5538.196961440609;3949.782761948092;3950.466686997276;3957.52509698838;3959.4060890866313;3975.662068724162;5708.48725087852;5728.169415434739;5739.8565035874435;5784.508316793078;5785.913211301876;4014.6186112319283;4019.437278780973;4033.2858535122455;4040.8989775255855;4066.5933406659096;4105.609967053125;4112.753234805921;4116.670666346685;4119.670426365884;4128.566500517462;4513.187626227245;4672.476862494283;4679;4695.483496815347;4714.622830173578;5601.347602457285;5639.266895303666;5666.631668941505;5715.942260786113;5727.854429114193;1439.6616795053153;1447.7394069067668;1451.992740036293;1453.1789538910482;1454.7236025155187;892.830362231174;893.3657103456619;924.5377311344328;926.5228407370209;954.7231302922214;5296.947030529645;5316.229146773696;5356.384015838151;5360.839174824761;5474.863128421821;5678.659280443187;5686.516646085129;5693.829185124453;5705.429457054344;5716.714164291769;5276.023935571931;5296;5398.4614384900115;5403;5464.371597266365;3001.5347621118763;3020.6828283030404;3039.5592639067213;3065.770067244921;3084.290613158941;5763.4812866842185;5774.8161626866395;5781.768729250867;5841.276823337126;5844.795432159939;5526.226328314039;5775.653460792366;5775.6823374714795;5781.682007489544;5794.768209271582;5761.85595360111;5795.319971817926;5797.652140871562;5806.216160818235;5844.766209351664;5534.889302214014;5694.316681998187;5708.971455142698;5749.54003679713;5866.67733274674;5715.685637289989;5720.39935806751;5725.08398656213;5742.454466825645;5806.65160090396;5887.409539802473;5941.851453713692;5945.672987985702;5958.076498142795;5969.880602388015;3866.284737323604;3995.780232087263;4014.698897582751;4018.3168861293066;4039.071013666932;5829.446202610745;5859.677717725566;5893.204417403767;5894.823155305347;5914.491804589802;5490.560755139659;5754.884902302014;5763.36602973681;5765.8558536036935;5779.450952159538;5399.5950303726595;5490.313710786152;5623.606347555632;5637.943620563742;5659.783146623496;5528.9494995950645;5553.278073850373;5568.6658800472105;5571.66570005801;5589.189567512769;5625.21247025425;5680.460356266313;5700.629459085146;5714.857128571819;5760.539156867524;5279.26090347344;5540.861478463071;5558.249636299048;5560.138178582326;5584.553235741212 20:30:58 INFO - PROCESS | 10016 | |5;yui.html;735.2573900360634;815.4658698552448;829.1294141151789;897.0625696147525;904.3217586809889;15317.69364612707;15970.121643309614;15976.360945562163;16038.919805400987;16063.116528590923;14682.412703491847;14799.186044767534;14804.55586332409;14862.628434289149;14878.404863805436;688.4664385101561;801.3348920396087;830.4228561149988;838.337713206566;841.5455653946862;817.0522194254665;820.0897004325194;822.48183644304;823.9258466737992;825.335604838105;864.8140649760301;870.3081050564784;870.9259712924377;871.333429926107;871.7907702151501;718.5221827484717;854.8162145138793;883.2757139145903;887.4630848336728;889.1286539191564;648.9772857949949;649.7660842096841;649.9350064993463;649.9512536559777;650.1255810934285;14887.851121488864;14922.701545969128;14927.328270227757;14960.177190254532;14983.700325993528;14108.365123569463;14160.36278367476;14188.077774944699;14346.713065738626;14493.42026318946;12502;12574.74850502994;12623.747525049539;12719.30043847588;12807.103502754811;4501.684882058257;4519.096180763828;4573.222552166139;4581.198290299184;4713.222318317474;58052.12921806134;58710;58915.41084589142;60062.39937600656;60923.39076609221;10590.735231619117;10981.450927453756;11036.944815275872;11130.387828669502;11212.981663300685;19428.417147485598;19676.114574844167;19684.212631494865;19686.507837303896;19689.11398987049;8180.550069746221;8189.836203275901;8242.093369729326;8249.340052795762;8561.14388561139;4806.831760888352;4811.1820990431015;4849.030193961151;4868.9756551217015;5020.874478138003;3446;3514.9297014059575;3532.593751718534;3536.2750636119536;3543.875964341236;634.7587916591666;645.4997377032744;646.0406296649472;646.1664452855857;648.5557393185683;657.5035847934779;727.9781606551812;746.1829296919864;754.9207333230041;777.5723352156291;9299.209567186865;9492.620295188253;9609.327347085777;9661.082197191256;9672.489082969376;720.4920531025614;724.3119036914952;734.3317581001263;745.117036311972;747.7270796159363;4501.279795232747;4541.613962813131;4603.079384123189;4660.580547750651;4705.341252224691;67010.32989670041;67447;68693;69564.3043569568;71264.64367678232;60586;62145.37854621396;62645.37354626395;63157.68421157865;63675.04487432692;56395;57051.714741425196;57389;57424.13863792046;57549.42450575525;8828.558572071499;8880.644774208959;8893.777655558662;8902.821943561223;9175.54122293896;37678;38028;38562;38591.228175436896;38803.417948730224;46742;49714.25428618646;50522.74738626283;50665.24002139897;51181;11254.887451125383;11399.658010259705;11427.257228280136;11537.307761534335;11639.709007274885;12232.449539770554;12538.373081345713;12671.493140274286;12799.29603871796;12951.093423460266;12122.333271670142;12141.210821296587;12172.2696638202;12322.32227227511;12541.372931353579;11050.447477626247;11068.612598559012;11155.49800258974;11750.294982300748;12564.87435125637;11672.649820505398;11917.880821192024;11988.700282492659;12234.204776689487;12426.813597796221;10032.64885728996;10187.337823041478;10237.795244094927;10313.27807053529;10457.790844183226;9514.286428518028;10419.687409377731;10481.213908956706;10490.31812932157;10507.94746026265 20:30:58 INFO - PROCESS | 10016 | __end_tp_report 20:30:58 INFO - PROCESS | 10016 | __start_cc_report 20:30:58 INFO - PROCESS | 10016 | _x_x_mozilla_cycle_collect,851 20:30:58 INFO - PROCESS | 10016 | __end_cc_report 20:30:58 INFO - PROCESS | 10016 | __startTimestamp1463542258218__endTimestamp 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | ------- Summary: start ------- 20:30:58 INFO - PROCESS | 10016 | Number of tests: 6 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | [#0] dojo.html Cycles:165 Average:5394.35 Median:5582.16 stddev:611.74 (11.0%) stddev-sans-first:587.12 20:30:58 INFO - PROCESS | 10016 | Values: 3123.9 3126.5 3150.3 3171.5 3183.1 5317.5 5331.2 5385.8 5393.0 5408.8 5407.6 5421.6 5426.3 5449.0 5450.7 4866.3 4875.0 4967.9 5010.3 5034.2 4953.2 4972.9 5015.3 5016.5 5026.5 4805.7 4842.5 4854.7 4889.4 4975.5 4848.3 4864.1 4914.4 4924.5 4966.7 4851.3 4875.0 4899.4 4911.5 4945.8 5215.3 5347.8 5365.4 5415.0 5429.4 5812.0 5819.9 5840.2 5842.0 5854.4 5710.6 5789.1 5803.5 5817.6 5827.7 5534.4 5557.5 5557.9 5559.5 5560.9 6041.0 6049.8 6051.7 6052.2 6052.4 5557.3 5635.6 5696.7 5706.5 5808.6 5816.1 5818.9 5827.3 5860.9 5864.8 5793.8 5794.3 5799.4 5800.2 5802.6 5596.3 5784.7 5871.7 5889.1 5919.5 4470.7 4476.1 4476.3 4479.1 4514.8 3861.7 3948.4 3993.1 4016.2 4043.7 5421.3 5437.6 5439.4 5460.6 5508.1 5756.7 5768.5 5788.0 5797.1 5797.9 5380.9 5471.4 5473.9 5482.0 5484.9 5028.5 5039.8 5049.8 5059.1 5083.0 6020.7 6022.0 6026.5 6028.5 6030.4 5730.3 5741.2 5783.6 5881.9 5888.9 5935.3 5942.8 5944.9 5955.6 5984.6 5713.4 5730.8 5731.3 5732.0 5734.1 5651.9 5780.4 5793.2 5812.5 5821.8 5695.7 5727.8 5740.7 5743.3 5745.6 5695.0 5722.2 5733.1 5745.7 5749.2 5449.1 5460.9 5470.1 5514.5 5542.9 5676.8 5695.1 5758.5 5768.9 5769.3 5442.2 5582.2 5590.8 5594.4 5621.9 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | [#1] ext.html Cycles:180 Average:57421.12 Median:41554.17 stddev:108424.08 (260.9%) stddev-sans-first:108644.28 20:30:58 INFO - PROCESS | 10016 | Values: 592.3 633.7 634.7 648.9 655.4 42026.8 43500.8 43510.1 43587.8 46624.3 45349.8 45832.8 45870.1 45920.3 46007.8 8785.4 8919.9 8921.9 8927.4 8933.2 8735.1 8815.7 8820.6 8833.9 8833.9 8882.1 8925.0 8932.7 8963.6 8966.4 8798.6 8894.0 8898.3 8899.1 8904.0 8648.8 8701.5 8707.7 8715.3 8720.5 40902.4 41464.8 41475.0 41502.2 41608.6 3444.4 3549.4 3560.4 3778.8 4497.6 32194.5 32509.5 32545.7 32576.2 32702.0 4379.7 4432.3 4438.2 4444.1 4462.6 339306.0 340191.0 341130.0 341598.0 342142.3 57194.0 57498.4 57641.0 57727.7 57781.7 46284.1 58372.7 61071.1 61083.0 61236.4 13350.8 13632.9 13694.6 13751.1 13812.1 11627.2 11630.8 11638.1 11681.9 11794.4 14503.2 15397.4 15837.8 15967.8 16223.7 6670.2 6826.4 6830.8 6908.6 6915.7 999.6 1103.9 1142.2 1155.3 1256.2 31866.2 33075.2 33128.7 33150.0 33301.3 1133.7 1151.3 1171.3 1207.7 1217.9 17207.3 17289.0 17352.5 17419.5 17503.7 472910.0 475291.0 475313.0 477831.9 479552.0 57142.7 57533.0 57647.7 57758.7 57761.4 1363.9 1367.0 1393.2 1396.1 1402.3 31105.7 31669.2 31852.5 32208.8 32624.3 49316.5 49333.8 49402.5 49635.5 49745.3 394386.0 405217.0 405553.0 406074.0 407269.0 35049.0 35545.5 40246.8 40536.8 40968.4 46511.5 47552.0 47919.0 48529.5 48632.5 38540.8 41075.2 41100.5 41606.2 41691.6 40014.4 40290.6 41136.4 41492.0 41728.8 40161.8 40759.4 41734.0 41773.0 41854.0 34552.8 36290.0 36587.5 37035.1 37221.6 27961.4 28202.6 28278.2 28461.6 28969.7 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | [#2] jquery.html Cycles:180 Average:29434.41 Median:22402.88 stddev:83467.36 (372.6%) stddev-sans-first:83673.00 20:30:58 INFO - PROCESS | 10016 | Values: 378.9 379.5 397.3 401.7 415.1 14319.4 16752.7 18029.0 19623.8 19655.8 13704.7 16495.6 17176.4 17269.3 17963.2 5619.9 5803.7 5866.8 5880.3 5881.2 4150.0 5760.8 5802.1 6111.7 6410.4 6416.8 6431.7 6461.3 6481.2 6482.8 6290.8 6306.5 6442.5 6449.6 6469.3 5470.1 5687.7 5696.8 5700.1 5744.2 21799.2 22319.0 22357.6 22448.2 22469.2 2416.3 2503.0 2583.8 2832.8 2853.2 9405.6 13643.7 14212.5 14317.1 14765.3 1940.4 1968.9 2003.4 2019.5 2068.6 77400.6 77959.6 78791.6 79727.0 80927.6 10176.9 10669.4 11211.7 11255.9 11335.9 15561.8 15627.9 15647.9 15662.8 15671.4 7545.3 7718.3 7745.4 7811.2 7931.2 6280.7 7328.5 7408.2 7522.5 7545.6 4527.9 4744.4 4828.5 4860.6 4870.9 1942.3 1946.5 1977.1 1992.6 2047.8 1013.8 1065.6 1067.6 1072.0 1086.5 18950.2 19354.5 19503.1 19511.3 19554.5 1041.3 1042.0 1055.0 1069.6 1075.4 10231.4 10521.8 10687.7 10807.7 10809.7 497184.0 500283.0 508395.0 511386.0 515020.0 91965.5 95020.5 95660.0 96762.2 98309.5 1018.2 1032.6 1053.8 1056.0 1058.4 16704.2 16944.6 16952.7 17134.3 17585.3 40328.4 40346.8 40492.0 40716.4 41039.2 55803.4 58060.7 58723.7 59721.7 61042.1 8251.0 8366.5 8549.2 8724.0 8874.2 11196.8 13260.3 13321.5 13439.5 13498.7 11333.5 11608.6 11755.2 12221.1 12310.1 11547.6 11557.0 11596.5 11867.3 12078.9 11845.6 12100.5 12130.7 12305.8 12536.3 7373.2 7696.5 7749.9 8529.7 8665.5 8820.0 10780.6 11167.9 11915.9 11986.0 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | [#3] mootools.html Cycles:180 Average:5861.75 Median:4539.10 stddev:3358.86 (74.0%) stddev-sans-first:3351.30 20:30:58 INFO - PROCESS | 10016 | Values: 1366.5 1507.8 1559.4 1687.3 1872.8 8450.9 8688.5 8698.0 9044.6 9059.2 8744.1 8920.6 8931.0 8955.6 8966.1 2032.6 2293.8 2335.9 2342.2 2368.5 2261.8 2264.9 2276.2 2276.4 2280.8 2326.4 2376.0 2378.3 2379.5 2380.0 1926.3 2255.5 2304.8 2314.5 2332.0 2281.3 2290.9 2296.4 2297.5 2311.8 8977.7 9009.5 9017.6 9038.5 9043.0 5140.3 5270.3 5278.4 5280.9 5294.7 3396.3 3522.3 3528.8 3528.9 3576.4 1134.7 1146.8 1150.8 1151.0 1186.3 12211.9 12292.3 12306.1 12328.7 12335.6 4521.2 4557.0 4637.7 4658.3 4660.3 9769.0 9792.6 9811.3 9822.1 9843.3 4586.9 5230.2 5233.1 5285.0 5286.8 4767.0 4865.5 4874.4 4924.2 4974.0 3760.1 3795.6 3796.1 3870.8 3923.8 1160.4 1161.2 1169.5 1180.2 1181.2 1005.0 1007.1 1024.7 1029.6 1042.4 6134.1 6139.2 6236.3 6326.7 6356.1 411.5 417.9 417.9 419.6 420.6 4212.6 4261.8 4311.1 4325.4 4330.3 10893.8 11216.7 11290.3 11306.7 11337.4 10604.4 11138.4 11165.0 11219.8 11220.2 7889.7 8286.1 8326.5 8360.0 8372.2 6142.7 6196.9 6319.7 6375.6 6485.4 10151.2 10269.9 10295.2 10408.2 10419.0 10396.9 10397.5 10420.7 10681.9 10833.3 7139.7 7353.6 7361.0 7810.7 7921.9 8164.4 8359.7 8499.7 8527.3 8882.5 7494.9 7609.2 7962.0 8044.3 8078.2 7688.0 7775.2 7791.3 7879.4 7935.2 7373.3 7404.8 7467.6 7485.4 7486.3 5290.3 5346.3 5414.9 5473.8 5513.5 5432.8 5467.0 5478.8 5491.1 5577.4 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | [#4] prototype.html Cycles:180 Average:4701.03 Median:5434.32 stddev:1397.81 (25.7%) stddev-sans-first:1362.25 20:30:58 INFO - PROCESS | 10016 | Values: 305.6 309.8 310.4 311.9 312.5 5395.9 5448.0 5453.5 5456.8 5470.6 5344.9 5363.6 5397.9 5403.1 5420.6 3988.6 4012.7 4161.8 4191.7 4194.7 4099.7 4138.2 4155.3 4159.5 4192.0 3928.6 4138.2 4145.8 4149.3 4172.1 4035.3 4108.7 4110.6 4112.7 4116.6 3583.6 3588.7 3601.9 3602.9 3609.7 5161.3 5197.7 5201.2 5210.5 5220.1 4546.8 4689.8 4703.3 4714.3 4731.6 5492.5 5496.7 5511.5 5524.6 5538.2 3949.8 3950.5 3957.5 3959.4 3975.7 5708.5 5728.2 5739.9 5784.5 5785.9 4014.6 4019.4 4033.3 4040.9 4066.6 4105.6 4112.8 4116.7 4119.7 4128.6 4513.2 4672.5 4679.0 4695.5 4714.6 5601.3 5639.3 5666.6 5715.9 5727.9 1439.7 1447.7 1452.0 1453.2 1454.7 892.8 893.4 924.5 926.5 954.7 5296.9 5316.2 5356.4 5360.8 5474.9 5678.7 5686.5 5693.8 5705.4 5716.7 5276.0 5296.0 5398.5 5403.0 5464.4 3001.5 3020.7 3039.6 3065.8 3084.3 5763.5 5774.8 5781.8 5841.3 5844.8 5526.2 5775.7 5775.7 5781.7 5794.8 5761.9 5795.3 5797.7 5806.2 5844.8 5534.9 5694.3 5709.0 5749.5 5866.7 5715.7 5720.4 5725.1 5742.5 5806.7 5887.4 5941.9 5945.7 5958.1 5969.9 3866.3 3995.8 4014.7 4018.3 4039.1 5829.4 5859.7 5893.2 5894.8 5914.5 5490.6 5754.9 5763.4 5765.9 5779.5 5399.6 5490.3 5623.6 5637.9 5659.8 5528.9 5553.3 5568.7 5571.7 5589.2 5625.2 5680.5 5700.6 5714.9 5760.5 5279.3 5540.9 5558.2 5560.1 5584.6 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - PROCESS | 10016 | [#5] yui.html Cycles:180 Average:15852.43 Median:4809.01 stddev:19161.09 (398.4%) stddev-sans-first:19181.21 20:30:58 INFO - PROCESS | 10016 | Values: 735.3 815.5 829.1 897.1 904.3 15317.7 15970.1 15976.4 16038.9 16063.1 14682.4 14799.2 14804.6 14862.6 14878.4 688.5 801.3 830.4 838.3 841.5 817.1 820.1 822.5 823.9 825.3 864.8 870.3 870.9 871.3 871.8 718.5 854.8 883.3 887.5 889.1 649.0 649.8 649.9 650.0 650.1 14887.9 14922.7 14927.3 14960.2 14983.7 14108.4 14160.4 14188.1 14346.7 14493.4 12502.0 12574.7 12623.7 12719.3 12807.1 4501.7 4519.1 4573.2 4581.2 4713.2 58052.1 58710.0 58915.4 60062.4 60923.4 10590.7 10981.5 11036.9 11130.4 11213.0 19428.4 19676.1 19684.2 19686.5 19689.1 8180.6 8189.8 8242.1 8249.3 8561.1 4806.8 4811.2 4849.0 4869.0 5020.9 3446.0 3514.9 3532.6 3536.3 3543.9 634.8 645.5 646.0 646.2 648.6 657.5 728.0 746.2 754.9 777.6 9299.2 9492.6 9609.3 9661.1 9672.5 720.5 724.3 734.3 745.1 747.7 4501.3 4541.6 4603.1 4660.6 4705.3 67010.3 67447.0 68693.0 69564.3 71264.6 60586.0 62145.4 62645.4 63157.7 63675.0 56395.0 57051.7 57389.0 57424.1 57549.4 8828.6 8880.6 8893.8 8902.8 9175.5 37678.0 38028.0 38562.0 38591.2 38803.4 46742.0 49714.3 50522.7 50665.2 51181.0 11254.9 11399.7 11427.3 11537.3 11639.7 12232.4 12538.4 12671.5 12799.3 12951.1 12122.3 12141.2 12172.3 12322.3 12541.4 11050.4 11068.6 11155.5 11750.3 12564.9 11672.6 11917.9 11988.7 12234.2 12426.8 10032.6 10187.3 10237.8 10313.3 10457.8 9514.3 10419.7 10481.2 10490.3 10507.9 20:30:58 INFO - PROCESS | 10016 | -------- Summary: end -------- 20:30:58 INFO - PROCESS | 10016 | 20:30:58 INFO - TEST-INFO | 10016: exit 0 20:30:59 INFO - TEST-OK | dromaeo_css | took 1114933ms 20:30:59 INFO - TEST-START | kraken 20:30:59 INFO - operating with platform_type : linux_ 20:30:59 INFO - Initialising browser for kraken test... 20:30:59 INFO - TEST-INFO | started process 10202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn5nzsQ/profile http://localhost:36728/getInfo.html) 20:31:03 INFO - PROCESS | 10202 | __metrics Screen width/height:1600/1200 20:31:03 INFO - PROCESS | 10202 | colorDepth:24 20:31:03 INFO - PROCESS | 10202 | Browser inner width/height: 1024/697 20:31:03 INFO - PROCESS | 10202 | __metrics 20:31:04 ERROR - PROCESS | 10202 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:31:05 INFO - TEST-INFO | 10202: exit 0 20:31:05 INFO - Browser initialized. 20:31:05 INFO - Running cycle 1/1 for kraken test... 20:31:05 INFO - TEST-INFO | started process 10284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn5nzsQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:17 INFO - PROCESS | 10284 | RSS: Main: 152739840 20:31:17 INFO - PROCESS | 10284 | 20:31:20 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36728/tests/kraken/driver.html?testName=audio-beat-detection) 20:31:21 INFO - PROCESS | 10284 | RSS: Main: 209031168 20:31:21 INFO - PROCESS | 10284 | 20:31:23 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36728/tests/kraken/driver.html?testName=audio-dft) 20:31:24 INFO - PROCESS | 10284 | RSS: Main: 197955584 20:31:24 INFO - PROCESS | 10284 | 20:31:27 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36728/tests/kraken/driver.html?testName=audio-fft) 20:31:28 INFO - PROCESS | 10284 | RSS: Main: 265543680 20:31:28 INFO - PROCESS | 10284 | 20:31:30 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36728/tests/kraken/driver.html?testName=audio-oscillator) 20:31:30 INFO - PROCESS | 10284 | RSS: Main: 174706688 20:31:30 INFO - PROCESS | 10284 | 20:31:33 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36728/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:33 INFO - PROCESS | 10284 | RSS: Main: 179236864 20:31:33 INFO - PROCESS | 10284 | 20:31:37 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36728/tests/kraken/driver.html?testName=imaging-darkroom) 20:31:37 INFO - PROCESS | 10284 | RSS: Main: 215293952 20:31:37 INFO - PROCESS | 10284 | 20:31:41 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36728/tests/kraken/driver.html?testName=imaging-desaturate) 20:31:41 INFO - PROCESS | 10284 | RSS: Main: 212836352 20:31:41 INFO - PROCESS | 10284 | 20:31:44 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36728/tests/kraken/driver.html?testName=json-parse-financial) 20:31:45 INFO - PROCESS | 10284 | RSS: Main: 214364160 20:31:45 INFO - PROCESS | 10284 | 20:31:46 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36728/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:31:47 INFO - PROCESS | 10284 | RSS: Main: 204226560 20:31:47 INFO - PROCESS | 10284 | 20:31:49 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:31:49 INFO - PROCESS | 10284 | RSS: Main: 208179200 20:31:49 INFO - PROCESS | 10284 | 20:31:52 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:52 INFO - PROCESS | 10284 | RSS: Main: 217030656 20:31:52 INFO - PROCESS | 10284 | 20:31:55 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:55 INFO - PROCESS | 10284 | RSS: Main: 223711232 20:31:55 INFO - PROCESS | 10284 | 20:31:58 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:59 INFO - PROCESS | 10284 | RSS: Main: 220377088 20:31:59 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:36728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36728/tests/kraken/driver.html?testName=ai-astar) 20:32:01 INFO - PROCESS | 10284 | RSS: Main: 265891840 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | __start_tp_report 20:32:01 INFO - PROCESS | 10284 | _x_x_mozilla_page_load 20:32:01 INFO - PROCESS | 10284 | _x_x_mozilla_page_load_details 20:32:01 INFO - PROCESS | 10284 | |i|pagename|runs| 20:32:01 INFO - PROCESS | 10284 | |0;ai-astar;111;107;112;111;110;111;110;112;110;111 20:32:01 INFO - PROCESS | 10284 | |1;audio-beat-detection;149;124;150;207;129;154;158;128;190;134 20:32:01 INFO - PROCESS | 10284 | |2;audio-dft;160;161;160;161;161;159;162;160;161;170 20:32:01 INFO - PROCESS | 10284 | |3;audio-fft;74;75;76;156;77;78;76;75;128;74 20:32:01 INFO - PROCESS | 10284 | |4;audio-oscillator;91;91;148;92;93;93;132;92;92;134 20:32:01 INFO - PROCESS | 10284 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;116;116;116 20:32:01 INFO - PROCESS | 10284 | |6;imaging-darkroom;146;145;145;145;145;146;145;146;147;145 20:32:01 INFO - PROCESS | 10284 | |7;imaging-desaturate;95;95;95;96;95;95;94;96;95;95 20:32:01 INFO - PROCESS | 10284 | |8;json-parse-financial;54;54;56;54;54;52;53;109;52;52 20:32:01 INFO - PROCESS | 10284 | |9;json-stringify-tinderbox;58;59;59;59;58;57;58;58;58;59 20:32:01 INFO - PROCESS | 10284 | |10;stanford-crypto-aes;80;83;79;79;78;78;85;79;79;80 20:32:01 INFO - PROCESS | 10284 | |11;stanford-crypto-ccm;128;125;139;127;120;117;119;119;189;121 20:32:01 INFO - PROCESS | 10284 | |12;stanford-crypto-pbkdf2;162;163;161;163;158;159;162;161;160;164 20:32:01 INFO - PROCESS | 10284 | |13;stanford-crypto-sha256-iterative;65;63;64;63;66;63;66;64;62;62 20:32:01 INFO - PROCESS | 10284 | __end_tp_report 20:32:01 INFO - PROCESS | 10284 | __start_cc_report 20:32:01 INFO - PROCESS | 10284 | _x_x_mozilla_cycle_collect,1853 20:32:01 INFO - PROCESS | 10284 | __end_cc_report 20:32:01 INFO - PROCESS | 10284 | __startTimestamp1463542321339__endTimestamp 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | ------- Summary: start ------- 20:32:01 INFO - PROCESS | 10284 | Number of tests: 14 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 20:32:01 INFO - PROCESS | 10284 | Values: 111.0 107.0 112.0 111.0 110.0 111.0 110.0 112.0 110.0 111.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:152.00 stddev:27.35 (18.0%) stddev-sans-first:28.99 20:32:01 INFO - PROCESS | 10284 | Values: 149.0 124.0 150.0 207.0 129.0 154.0 158.0 128.0 190.0 134.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:3.10 (1.9%) stddev-sans-first:3.24 20:32:01 INFO - PROCESS | 10284 | Values: 160.0 161.0 160.0 161.0 161.0 159.0 162.0 160.0 161.0 170.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.50 stddev:28.78 (38.1%) stddev-sans-first:30.02 20:32:01 INFO - PROCESS | 10284 | Values: 74.0 75.0 76.0 156.0 77.0 78.0 76.0 75.0 128.0 74.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:92.00 stddev:22.61 (24.6%) stddev-sans-first:23.34 20:32:01 INFO - PROCESS | 10284 | Values: 91.0 91.0 148.0 92.0 93.0 93.0 132.0 92.0 92.0 134.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:32:01 INFO - PROCESS | 10284 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 20:32:01 INFO - PROCESS | 10284 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 147.0 145.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 20:32:01 INFO - PROCESS | 10284 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 94.0 96.0 95.0 95.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:54.00 stddev:17.61 (32.6%) stddev-sans-first:18.59 20:32:01 INFO - PROCESS | 10284 | Values: 54.0 54.0 56.0 54.0 54.0 52.0 53.0 109.0 52.0 52.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 20:32:01 INFO - PROCESS | 10284 | Values: 58.0 59.0 59.0 59.0 58.0 57.0 58.0 58.0 58.0 59.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.26 (2.8%) stddev-sans-first:2.40 20:32:01 INFO - PROCESS | 10284 | Values: 80.0 83.0 79.0 79.0 78.0 78.0 85.0 79.0 79.0 80.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:126.00 stddev:21.58 (17.1%) stddev-sans-first:22.87 20:32:01 INFO - PROCESS | 10284 | Values: 128.0 125.0 139.0 127.0 120.0 117.0 119.0 119.0 189.0 121.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 20:32:01 INFO - PROCESS | 10284 | Values: 162.0 163.0 161.0 163.0 158.0 159.0 162.0 161.0 160.0 164.0 20:32:01 INFO - PROCESS | 10284 | 20:32:01 INFO - PROCESS | 10284 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.48 (2.3%) stddev-sans-first:1.50 20:32:01 INFO - PROCESS | 10284 | Values: 65.0 63.0 64.0 63.0 66.0 63.0 66.0 64.0 62.0 62.0 20:32:01 INFO - PROCESS | 10284 | -------- Summary: end -------- 20:32:01 INFO - PROCESS | 10284 | 20:32:02 INFO - TEST-INFO | 10284: exit 0 20:32:02 INFO - TEST-OK | kraken | took 63358ms 20:32:02 INFO - SUITE-END | took 1178s 20:32:02 INFO - Completed test suite (00:19:38) 20:32:02 INFO - javascript benchmark 20:32:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.8750449982, 3126.4997600383945, 3150.3384289299247, 3171.5401266816325, 3183.0928185467146, 5317.521423071923, 5331.173668081444, 5385.838424847256, 5393.0, 5408.837734867955, 5407.648502847322, 5421.593380496469, 5426.2674538937235, 5449.0, 5450.700211488366, 4866.2943873138465, 4874.951250487503, 4967.875803104916, 5010.323606313137, 5034.1945288753805, 4953.182724850395, 4972.925406118911, 5015.348004759395, 5016.548510634042, 5026.472220416858, 4805.663603547753, 4842.467328593852, 4854.660173787836, 4889.3888263967, 4975.502449755014, 4848.2727590861305, 4864.075825593161, 4914.385701787277, 4924.482929292409, 4966.652334336598, 4851.296561998491, 4875.0, 4899.412070551521, 4911.45973942866, 4945.8268960586565, 5215.269862219292, 5347.839564813062, 5365.436629153961, 5415.025295446818, 5429.429909859447, 5811.970940145272, 5819.88360232793, 5840.240768700041, 5842.006858834008, 5854.414558544154, 5710.571707121982, 5789.131630255453, 5803.53571714266, 5817.621854579481, 5827.708614569297, 5534.418886016951, 5557.47204015626, 5557.916631250535, 5559.527440167591, 5560.888782224373, 6041.0, 6049.758009679564, 6051.727672254759, 6052.213212282375, 6052.364501727256, 5557.277553918046, 5635.605507614428, 5696.743646535916, 5706.457886500776, 5808.593398462067, 5816.127580862904, 5818.912716309259, 5827.271591051119, 5860.912086318709, 5864.794732184353, 5793.797217097382, 5794.275715535558, 5799.39106393831, 5800.1589769484035, 5802.564807639444, 5596.300462442195, 5784.739686714108, 5871.6770577618645, 5889.057750759944, 5919.496842768327, 4470.6870519064005, 4476.104779044139, 4476.2837945928495, 4479.10417916418, 4514.774261286922, 3861.710371722132, 3948.407738839197, 3993.1414745829784, 4016.2369149861433, 4043.6765058795227, 5421.26812880264, 5437.592180586472, 5439.428859969726, 5460.645058071213, 5508.14623733322, 5756.740946657411, 5768.451997060272, 5788.0, 5797.101449275369, 5797.855053623609, 5380.865478363072, 5471.398146203915, 5473.863153421196, 5481.972590137104, 5484.890302193934, 5028.472010438924, 5039.77321020555, 5049.7727602257255, 5059.064073146406, 5082.974585127125, 6020.729067191899, 6022.0, 6026.487748541423, 6028.517718582503, 6030.366811484819, 5730.283714535683, 5741.224934633771, 5783.595148339576, 5881.911771323348, 5888.94111058901, 5935.2877654681715, 5942.7920022799, 5944.851378715567, 5955.642661440327, 5984.640921544721, 5713.428657134254, 5730.770769169187, 5731.283589551306, 5731.971340143273, 5734.05388110957, 5651.858703532444, 5780.393058728773, 5793.217915581343, 5812.505936995233, 5821.76712931478, 5695.658260504383, 5727.770889164387, 5740.68426236561, 5743.282089738783, 5745.597808153389, 5694.971525142348, 5722.227499287709, 5733.082706767064, 5745.6552606843725, 5749.195112684144, 5449.073657478159, 5460.863478413072, 5470.097433923358, 5514.503694667499, 5542.889142217053, 5676.772929082956, 5695.117256825199, 5758.4817366435545, 5768.94231057684, 5769.307683078057, 5442.156465747816, 5582.16267559853, 5590.832275031756, 5594.356648985418, 5621.943780562142], "value": 5353.166627602311, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2744637818672, 633.6989929783354, 634.7461015593764, 648.8961766117422, 655.3544758412966, 42026.78986605066, 43500.78249608748, 43510.129797404035, 43587.78206108969, 46624.300635490494, 45349.77325113378, 45832.77083614586, 45870.08259834801, 45920.31119533201, 46007.76996115023, 8785.38502304839, 8919.910800891972, 8921.910780892173, 8927.37508374414, 8933.240674542672, 8735.126487351246, 8815.691450799224, 8820.603072861737, 8833.867491987625, 8833.911660883405, 8882.067382924797, 8925.018247992715, 8932.687355942544, 8963.551822408854, 8966.417182883124, 8798.604062817189, 8893.955530222373, 8898.332625053083, 8899.110088991114, 8904.020557738644, 8648.783780405478, 8701.47791132534, 8707.695230666895, 8715.302775777986, 8720.52037137957, 40902.38646420306, 41464.792676036726, 41475.0, 41502.169956601, 41608.58391416108, 3444.3800115979116, 3549.378858699717, 3560.4481305397703, 3778.792166430845, 4497.617702495292, 32194.517082243787, 32509.51235731466, 32545.6745432545, 32576.185595360068, 32702.0, 4379.715318504287, 4432.335149727534, 4438.15675021748, 4444.111177764427, 4462.620677242438, 339306.0, 340191.0, 341130.0, 341598.0, 342142.28928855446, 57194.0, 57498.42501574931, 57641.0, 57727.71136144376, 57781.711091444275, 46284.07431851344, 58372.70813645905, 61071.08393374103, 61083.0, 61236.387636123065, 13350.799738003938, 13632.863671363359, 13694.589162325146, 13751.106178098391, 13812.1022133561, 11627.186096973131, 11630.825537616942, 11638.06895448362, 11681.941590291994, 11794.410279485992, 14503.202323872289, 15397.384104635914, 15837.841621583868, 15967.840321596868, 16223.728677985091, 6670.166229221348, 6826.419754320938, 6830.829229269308, 6908.5509441886115, 6915.654217289115, 999.6351331763999, 1103.8730545987314, 1142.2404101272562, 1155.2721785275392, 1256.2399748152418, 31866.20334491656, 33075.173120671694, 33128.66871331256, 33150.0, 33301.3339733204, 1133.6939026462808, 1151.3494875395374, 1171.344047333496, 1207.6980754811298, 1217.8538575371012, 17207.311707531808, 17289.0, 17352.47942561725, 17419.47741567755, 17503.73744393835, 472910.0, 475291.0, 475313.0, 477831.8867245271, 479552.0, 57142.7142864283, 57533.0, 57647.71176144092, 57758.7112064437, 57761.422385776445, 1363.9429442182388, 1366.9931650341684, 1393.2197969137314, 1396.1274203622736, 1402.2778269191374, 31105.68894311028, 31669.208269792518, 31852.522212166372, 32208.83895580507, 32624.34751304913, 49316.50683493119, 49333.75333123455, 49402.50597493979, 49635.503644963086, 49745.25382119199, 394386.0, 405217.0, 405553.0, 406074.0, 407269.0, 35049.0, 35545.46681799827, 40246.79876600715, 40536.79731601323, 40968.38547421731, 46511.53488465072, 47552.0, 47919.0, 48529.514704852496, 48632.51367486421, 38540.80729596446, 41075.178496430504, 41100.47799342224, 41606.1678766429, 41691.58308416877, 40014.39978400268, 40290.597094028686, 41136.38295425511, 41492.0, 41728.791356043024, 40161.799191003855, 40759.38860917148, 41734.0, 41773.0, 41853.95365115896, 34552.82723586366, 36290.0, 36587.451188231666, 37035.07412314714, 37221.6277837229, 27961.440771184054, 28202.576961345185, 28278.15165545037, 28461.630005752126, 28969.69636366411], "value": 20021.302183325693, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.93365700583206, 379.4933763425826, 397.3324814311957, 401.7328476563086, 415.09923466078624, 14319.433516915813, 16752.748708769348, 18029.0, 19623.803761962376, 19655.803441965578, 13704.72590548191, 16495.587610309747, 17176.39882604109, 17269.309227630878, 17963.19165637546, 5619.915701264485, 5803.738831752581, 5866.794662186824, 5880.3237627672725, 5881.176635271066, 4149.958500414988, 5760.798372056979, 5802.071668533035, 6111.663858487781, 6410.423061924426, 6416.839579010515, 6431.6784160792, 6461.321561236073, 6481.157449531554, 6482.837929051764, 6290.811275661737, 6306.49548036156, 6442.452391546724, 6449.645269510175, 6469.256035555877, 5470.070088084995, 5687.658740475544, 5696.829095127153, 5700.144978253254, 5744.167095771089, 21799.237026703988, 22319.0, 22357.552848943094, 22448.21431249915, 22469.213577524708, 2416.299273210784, 2503.048841440241, 2583.8191326607143, 2832.830030198195, 2853.1868417500914, 9405.623775048989, 13643.658908527366, 14212.50256241037, 14317.140971541638, 14765.33555989983, 1940.417874637603, 1968.8523360748002, 2003.4089943466713, 2019.4648418169197, 2068.586282743457, 77400.61299693465, 77959.61020194863, 78791.60604196943, 79727.0, 80927.5953620234, 10176.949115254525, 10669.413182274895, 11211.66365009051, 11255.943720281346, 11335.886641133648, 15561.766573501407, 15627.921860390625, 15647.921760391126, 15662.765058524132, 15671.373145074069, 7545.283198096172, 7718.343940764986, 7745.419093568005, 7811.179826118289, 7931.167227441036, 6280.685965701788, 7328.487005909536, 7408.185099639036, 7522.548647081193, 7545.622718864035, 4527.886802829889, 4744.430668319824, 4828.5412885775795, 4860.6111511079025, 4870.853874383774, 1942.2716481319505, 1946.464722201406, 1977.0707767349322, 1992.601479704065, 2047.7952204779403, 1013.7566983923805, 1065.5950738719391, 1067.6209945469247, 1072.035168348477, 1086.5219303506433, 18950.24199032051, 19354.516137096685, 19503.122359493856, 19511.317103901296, 19554.511137221398, 1041.2971244409994, 1041.9895801041891, 1054.99472502637, 1069.5935544493043, 1075.3977772447297, 10231.43727095017, 10521.84217236742, 10687.73280667974, 10807.67576972692, 10809.67570972872, 497184.0, 500283.0, 508395.0, 511386.0, 515020.0, 91965.54017229872, 95020.52489737507, 95660.0, 96762.19612783285, 98309.50845245727, 1018.1905385218917, 1032.6437379104198, 1053.8261186904228, 1055.9524821383056, 1058.4284486377271, 16704.164791760606, 16944.57638559046, 16952.66094678075, 17134.314627414762, 17585.29658813633, 40328.39507407333, 40346.79826600848, 40492.0, 40716.38925416062, 41039.1792164161, 55803.44196557983, 58060.709696451246, 58723.70638146782, 59721.70139149277, 61042.08436873539, 8251.0, 8366.498010119412, 8549.187827156411, 8724.0, 8874.156955089256, 11196.83204751913, 13260.336983150997, 13321.467141314239, 13439.46242150303, 13498.662533436349, 11333.546658133911, 11608.593699220486, 11755.235909665844, 12221.083418743452, 12310.138290319592, 11547.595834145764, 11557.017653499546, 11596.47815848272, 11867.287962721919, 12078.939605301917, 11845.5716578103, 12100.45547950362, 12130.696732581757, 12305.815412768994, 12536.310502922426, 7373.225811289737, 7696.499727517694, 7749.883751743616, 8529.74410767678, 8665.523396213268, 8819.955900220459, 10780.622678206226, 11167.888321116685, 11915.94042029819, 11986.0], "value": 9311.051119515525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.4807373198196, 1507.8416766239548, 1559.4230134850106, 1687.2660392729165, 1872.8033556476569, 8450.91549084509, 8688.47869127852, 8698.043215246318, 9044.638214471413, 9059.229965452945, 8744.125587441253, 8920.643174273022, 8930.955345223281, 8955.552222388887, 8966.0585638508, 2032.573159636478, 2293.805026572735, 2335.9065637374483, 2342.227065068523, 2368.4789346343864, 2261.7625149359246, 2264.920727774528, 2276.2488378834946, 2276.408133885185, 2280.8175345972363, 2326.4300246439648, 2375.95248095038, 2378.2746262389965, 2379.4884099918513, 2380.0, 1926.3354142820774, 2255.5263394687217, 2304.7580004099664, 2314.5486630107134, 2331.985586269978, 2281.2927992322434, 2290.919817806369, 2296.391456264075, 2297.517521320508, 2311.8150547956125, 8977.685780997634, 9009.549522523914, 9017.639294428214, 9038.457692538468, 9042.954785226031, 5140.33175687162, 5270.262163297141, 5278.392984806758, 5280.867978300535, 5294.682319060868, 3396.2698019925833, 3522.3131489359585, 3528.788272703646, 3528.8764893228613, 3576.409892367756, 1134.6766171641043, 1146.776378606172, 1150.8388825564427, 1151.027381862325, 1186.3119390753343, 12211.938940305241, 12292.262464252173, 12306.07704422172, 12328.691782705415, 12335.568255111119, 4521.208788462071, 4557.0, 4637.7449240291435, 4658.34783130362, 4660.347551342815, 9768.951155244178, 9792.55933482995, 9811.31320807551, 9822.066903644143, 9843.310968232156, 4586.862394128181, 5230.189320655304, 5233.084210263189, 5285.0, 5286.788528458896, 4766.976165119152, 4865.464798872121, 4874.415070191529, 4924.162892308316, 4973.980334031515, 3760.0787806987464, 3795.6394142556414, 3796.088938654703, 3870.806459677005, 3923.843046278117, 1160.4197901049474, 1161.2219812725493, 1169.5497233565138, 1180.1738782852037, 1181.1554738362113, 1005.0401866217891, 1007.0885848307294, 1024.6721049264313, 1029.5984566019258, 1042.4110377636762, 6134.110553969649, 6139.201903752483, 6236.251649802053, 6326.746930122744, 6356.078368636522, 411.51646814992864, 417.87046015735217, 417.9080602267496, 419.5950907374398, 420.5626148805208, 4212.620864122244, 4261.765602891809, 4311.116221174651, 4325.437693099877, 4330.2638551446325, 10893.782124357469, 11216.719582010515, 11290.322580645188, 11306.660800175843, 11337.43312834355, 10604.416757078281, 11138.3873886937, 11165.0, 11219.775604487864, 11220.214584978972, 7889.6844126235455, 8286.129956354496, 8326.50040997542, 8360.0, 8372.246497815104, 6142.662153581596, 6196.938030619636, 6319.715612797343, 6375.6174629522375, 6485.416312531895, 10151.187904967732, 10269.897301026895, 10295.227857910537, 10408.167346612405, 10419.0, 10396.896031039592, 10397.532111055172, 10420.739481513023, 10681.946590266998, 10833.29583577065, 7139.678714457966, 7353.5955522446775, 7361.0, 7810.726624568113, 7921.881171782313, 8164.387670924586, 8359.707410240855, 8499.702510412106, 8527.275181609633, 8882.467051976902, 7494.850102998019, 7609.201033891583, 7961.960190199012, 8044.2760151586635, 8078.23256790604, 7687.961560192163, 7775.22247775218, 7791.259830316111, 7879.369650428067, 7935.1668074853615, 7373.262673732584, 7404.777856664308, 7467.58928258951, 7485.401167906663, 7486.288802563748, 5290.312259406252, 5346.331708536433, 5414.945850541444, 5473.781048758165, 5513.476219759116, 5432.809851655173, 5467.0, 5478.753456094565, 5491.066518691752, 5577.386487486455], "value": 4586.116786448698, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.55846801372024, 309.83269034721235, 310.4443046945966, 311.92669722615193, 312.45944515987344, 5395.919061214085, 5448.046591846426, 5453.509184173424, 5456.836294911149, 5470.589705772063, 5344.946550534493, 5363.6245462817615, 5397.892042159155, 5403.108487099624, 5420.5934554908445, 3988.5612582615963, 4012.6589239914642, 4161.813883043334, 4191.748495090289, 4194.748315101088, 4099.672026237894, 4138.193052354792, 4155.33514637658, 4159.459270294858, 4191.9939214588585, 3928.607139286077, 4138.213739389522, 4145.813438395265, 4149.336106223005, 4172.102997855461, 4035.2938235808765, 4108.650764685005, 4110.630043296118, 4112.717441819789, 4116.629503344683, 3583.552055993001, 3588.65907738767, 3601.873934412283, 3602.9279414411826, 3609.657082577151, 5161.303224064778, 5197.688138711689, 5201.219817027439, 5210.531052205281, 5220.138677118271, 4546.795394207269, 4689.812407503696, 4703.294505824119, 4714.339992401066, 4731.574158325767, 5492.47821456961, 5496.697681627509, 5511.5039646432015, 5524.640898341635, 5538.196961440609, 3949.782761948092, 3950.466686997276, 3957.52509698838, 3959.4060890866313, 3975.662068724162, 5708.48725087852, 5728.169415434739, 5739.8565035874435, 5784.508316793078, 5785.913211301876, 4014.6186112319283, 4019.437278780973, 4033.2858535122455, 4040.8989775255855, 4066.5933406659096, 4105.609967053125, 4112.753234805921, 4116.670666346685, 4119.670426365884, 4128.566500517462, 4513.187626227245, 4672.476862494283, 4679.0, 4695.483496815347, 4714.622830173578, 5601.347602457285, 5639.266895303666, 5666.631668941505, 5715.942260786113, 5727.854429114193, 1439.6616795053153, 1447.7394069067668, 1451.992740036293, 1453.1789538910482, 1454.7236025155187, 892.830362231174, 893.3657103456619, 924.5377311344328, 926.5228407370209, 954.7231302922214, 5296.947030529645, 5316.229146773696, 5356.384015838151, 5360.839174824761, 5474.863128421821, 5678.659280443187, 5686.516646085129, 5693.829185124453, 5705.429457054344, 5716.714164291769, 5276.023935571931, 5296.0, 5398.4614384900115, 5403.0, 5464.371597266365, 3001.5347621118763, 3020.6828283030404, 3039.5592639067213, 3065.770067244921, 3084.290613158941, 5763.4812866842185, 5774.8161626866395, 5781.768729250867, 5841.276823337126, 5844.795432159939, 5526.226328314039, 5775.653460792366, 5775.6823374714795, 5781.682007489544, 5794.768209271582, 5761.85595360111, 5795.319971817926, 5797.652140871562, 5806.216160818235, 5844.766209351664, 5534.889302214014, 5694.316681998187, 5708.971455142698, 5749.54003679713, 5866.67733274674, 5715.685637289989, 5720.39935806751, 5725.08398656213, 5742.454466825645, 5806.65160090396, 5887.409539802473, 5941.851453713692, 5945.672987985702, 5958.076498142795, 5969.880602388015, 3866.284737323604, 3995.780232087263, 4014.698897582751, 4018.3168861293066, 4039.071013666932, 5829.446202610745, 5859.677717725566, 5893.204417403767, 5894.823155305347, 5914.491804589802, 5490.560755139659, 5754.884902302014, 5763.36602973681, 5765.8558536036935, 5779.450952159538, 5399.5950303726595, 5490.313710786152, 5623.606347555632, 5637.943620563742, 5659.783146623496, 5528.9494995950645, 5553.278073850373, 5568.6658800472105, 5571.66570005801, 5589.189567512769, 5625.21247025425, 5680.460356266313, 5700.629459085146, 5714.857128571819, 5760.539156867524, 5279.26090347344, 5540.861478463071, 5558.249636299048, 5560.138178582326, 5584.553235741212], "value": 4246.8432301057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.2573900360634, 815.4658698552448, 829.1294141151789, 897.0625696147525, 904.3217586809889, 15317.69364612707, 15970.121643309614, 15976.360945562163, 16038.919805400987, 16063.116528590923, 14682.412703491847, 14799.186044767534, 14804.55586332409, 14862.628434289149, 14878.404863805436, 688.4664385101561, 801.3348920396087, 830.4228561149988, 838.337713206566, 841.5455653946862, 817.0522194254665, 820.0897004325194, 822.48183644304, 823.9258466737992, 825.335604838105, 864.8140649760301, 870.3081050564784, 870.9259712924377, 871.333429926107, 871.7907702151501, 718.5221827484717, 854.8162145138793, 883.2757139145903, 887.4630848336728, 889.1286539191564, 648.9772857949949, 649.7660842096841, 649.9350064993463, 649.9512536559777, 650.1255810934285, 14887.851121488864, 14922.701545969128, 14927.328270227757, 14960.177190254532, 14983.700325993528, 14108.365123569463, 14160.36278367476, 14188.077774944699, 14346.713065738626, 14493.42026318946, 12502.0, 12574.74850502994, 12623.747525049539, 12719.30043847588, 12807.103502754811, 4501.684882058257, 4519.096180763828, 4573.222552166139, 4581.198290299184, 4713.222318317474, 58052.12921806134, 58710.0, 58915.41084589142, 60062.39937600656, 60923.39076609221, 10590.735231619117, 10981.450927453756, 11036.944815275872, 11130.387828669502, 11212.981663300685, 19428.417147485598, 19676.114574844167, 19684.212631494865, 19686.507837303896, 19689.11398987049, 8180.550069746221, 8189.836203275901, 8242.093369729326, 8249.340052795762, 8561.14388561139, 4806.831760888352, 4811.1820990431015, 4849.030193961151, 4868.9756551217015, 5020.874478138003, 3446.0, 3514.9297014059575, 3532.593751718534, 3536.2750636119536, 3543.875964341236, 634.7587916591666, 645.4997377032744, 646.0406296649472, 646.1664452855857, 648.5557393185683, 657.5035847934779, 727.9781606551812, 746.1829296919864, 754.9207333230041, 777.5723352156291, 9299.209567186865, 9492.620295188253, 9609.327347085777, 9661.082197191256, 9672.489082969376, 720.4920531025614, 724.3119036914952, 734.3317581001263, 745.117036311972, 747.7270796159363, 4501.279795232747, 4541.613962813131, 4603.079384123189, 4660.580547750651, 4705.341252224691, 67010.32989670041, 67447.0, 68693.0, 69564.3043569568, 71264.64367678232, 60586.0, 62145.37854621396, 62645.37354626395, 63157.68421157865, 63675.04487432692, 56395.0, 57051.714741425196, 57389.0, 57424.13863792046, 57549.42450575525, 8828.558572071499, 8880.644774208959, 8893.777655558662, 8902.821943561223, 9175.54122293896, 37678.0, 38028.0, 38562.0, 38591.228175436896, 38803.417948730224, 46742.0, 49714.25428618646, 50522.74738626283, 50665.24002139897, 51181.0, 11254.887451125383, 11399.658010259705, 11427.257228280136, 11537.307761534335, 11639.709007274885, 12232.449539770554, 12538.373081345713, 12671.493140274286, 12799.29603871796, 12951.093423460266, 12122.333271670142, 12141.210821296587, 12172.2696638202, 12322.32227227511, 12541.372931353579, 11050.447477626247, 11068.612598559012, 11155.49800258974, 11750.294982300748, 12564.87435125637, 11672.649820505398, 11917.880821192024, 11988.700282492659, 12234.204776689487, 12426.813597796221, 10032.64885728996, 10187.337823041478, 10237.795244094927, 10313.27807053529, 10457.790844183226, 9514.286428518028, 10419.687409377731, 10481.213908956706, 10490.31812932157, 10507.94746026265], "value": 6973.286607442814, "unit": "score"}], "name": "dromaeo_css", "value": 7167.196230449359, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 112.0, 111.0, 110.0, 111.0, 110.0, 112.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 150.0, 207.0, 129.0, 154.0, 158.0, 128.0, 190.0, 134.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 159.0, 162.0, 160.0, 161.0, 170.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 156.0, 77.0, 78.0, 76.0, 75.0, 128.0, 74.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 148.0, 92.0, 93.0, 93.0, 132.0, 92.0, 92.0, 134.0], "value": 105.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 54.0, 54.0, 52.0, 53.0, 109.0, 52.0, 52.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 58.0, 57.0, 58.0, 58.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 79.0, 79.0, 78.0, 78.0, 85.0, 79.0, 79.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 139.0, 127.0, 120.0, 117.0, 119.0, 119.0, 189.0, 121.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 158.0, 159.0, 162.0, 161.0, 160.0, 164.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 66.0, 63.0, 66.0, 64.0, 62.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1528.8999999999999, "alertThreshold": 2.0}]} 20:32:02 INFO - Return code: 0 20:32:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:32:02 ERROR - # TBPL SUCCESS # 20:32:02 INFO - Running post-action listener: _resource_record_post_action 20:32:02 INFO - ##### 20:32:02 INFO - ##### Finished run-tests step (success) 20:32:02 INFO - ##### 20:32:02 INFO - Running post-run listener: _resource_record_post_run 20:32:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280723456; Read time: 12; Write time: 695044 20:32:02 INFO - TinderboxPrint: CPU usage
13.1% 20:32:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:32:02 INFO - TinderboxPrint: I/O write bytes / time
280,723,456 / 695,044 20:32:02 INFO - TinderboxPrint: CPU idle
8,292.4 (86.9%) 20:32:02 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 20:32:02 INFO - TinderboxPrint: Swap in / out
0 / 0 20:32:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 966656; Read time: 0; Write time: 108 20:32:02 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279756800; Read time: 12; Write time: 694936 20:32:03 INFO - Running post-run listener: _upload_blobber_files 20:32:03 INFO - Blob upload gear active. 20:32:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:32:03 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 20:32:03 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'] 20:32:03 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 20:32:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:04 INFO - (blobuploader) - INFO - Done attempting. 20:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:08 INFO - (blobuploader) - INFO - Done attempting. 20:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:09 INFO - (blobuploader) - INFO - Done attempting. 20:32:09 INFO - (blobuploader) - INFO - Iteration through files over. 20:32:09 INFO - Return code: 0 20:32:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:32:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:32:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3c6384593bb059ebdce1aca3b7d8eae5bd5e5386cad9d2945a985409a590ff66bb79f059686b886026200f7bdf9cc7130bd2fe1bf0bde5392c027771e94c928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec3a38cfc1a4bda3d291afc6b7078cd62a3d5da210860f1be172b5743dc576a58360eb968c0d89fd2bb08ccf1df4684f1e7bd04fca1917b0572bd3044be0c9ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49275286e2154f9d85ff90bdd1523425d6e65b1a174f804380d6e5a4d91aa84cd12efbeb6ef6d43cd43ca37a88335eaef1d2ff522e254f8db36a9c687d3c8ebb"} 20:32:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:32:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:32:09 INFO - Contents: 20:32:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3c6384593bb059ebdce1aca3b7d8eae5bd5e5386cad9d2945a985409a590ff66bb79f059686b886026200f7bdf9cc7130bd2fe1bf0bde5392c027771e94c928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec3a38cfc1a4bda3d291afc6b7078cd62a3d5da210860f1be172b5743dc576a58360eb968c0d89fd2bb08ccf1df4684f1e7bd04fca1917b0572bd3044be0c9ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49275286e2154f9d85ff90bdd1523425d6e65b1a174f804380d6e5a4d91aa84cd12efbeb6ef6d43cd43ca37a88335eaef1d2ff522e254f8db36a9c687d3c8ebb"} 20:32:09 INFO - Running post-run listener: copy_logs_to_upload_dir 20:32:09 INFO - Copying logs to upload dir... 20:32:09 INFO - mkdir: /builds/slave/test/build/upload/logs 20:32:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.395306 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-17 20:32:09.199316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 20:32:09.203029) ========= 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=8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3c6384593bb059ebdce1aca3b7d8eae5bd5e5386cad9d2945a985409a590ff66bb79f059686b886026200f7bdf9cc7130bd2fe1bf0bde5392c027771e94c928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec3a38cfc1a4bda3d291afc6b7078cd62a3d5da210860f1be172b5743dc576a58360eb968c0d89fd2bb08ccf1df4684f1e7bd04fca1917b0572bd3044be0c9ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49275286e2154f9d85ff90bdd1523425d6e65b1a174f804380d6e5a4d91aa84cd12efbeb6ef6d43cd43ca37a88335eaef1d2ff522e254f8db36a9c687d3c8ebb"} build_url:https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3c6384593bb059ebdce1aca3b7d8eae5bd5e5386cad9d2945a985409a590ff66bb79f059686b886026200f7bdf9cc7130bd2fe1bf0bde5392c027771e94c928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec3a38cfc1a4bda3d291afc6b7078cd62a3d5da210860f1be172b5743dc576a58360eb968c0d89fd2bb08ccf1df4684f1e7bd04fca1917b0572bd3044be0c9ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49275286e2154f9d85ff90bdd1523425d6e65b1a174f804380d6e5a4d91aa84cd12efbeb6ef6d43cd43ca37a88335eaef1d2ff522e254f8db36a9c687d3c8ebb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 20:32:09.231794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:32:09.232293) ========= 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=8783db0840cc980e80bb0bd400000236-1463540830.457935-313611535 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-05-17 20:32:09.314299) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 20:32:09.314675) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 20:32:09.314981) ========= ========= Total master_lag: 0.20 =========