builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1464891622.81 results: success (0) buildid: 20160602083053 builduid: 34356c4fc4a746598981ec065b23e308 revision: 60b8c047de4c4551de50cb1f088615d49c2370c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:22.805629) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:22.806100) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:22.806386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:22.838933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:22.839211) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 11:20:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2016-06-02 11:20:23 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107591 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.174923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.175212) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017668 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.214758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.215134) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60b8c047de4c4551de50cb1f088615d49c2370c5 --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 60b8c047de4c4551de50cb1f088615d49c2370c5 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 11:20:23,327 truncating revision to first 12 chars 2016-06-02 11:20:23,327 Setting DEBUG logging. 2016-06-02 11:20:23,327 attempt 1/10 2016-06-02 11:20:23,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60b8c047de4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 11:20:23,628 unpacking tar archive at: fx-team-60b8c047de4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.882079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.882370) ========= script_repo_revision: 60b8c047de4c4551de50cb1f088615d49c2370c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.885806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.886084) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:20:23.896776) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-02 11:20:23.897071) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:24 INFO - MultiFileLogger online at 20160602 11:20:24 in /builds/slave/test 11:20:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:20:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:24 INFO - {'append_to_log': False, 11:20:24 INFO - 'base_work_dir': '/builds/slave/test', 11:20:24 INFO - 'blob_upload_branch': 'Fx-Team', 11:20:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:24 INFO - 'branch': 'Fx-Team', 11:20:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:24 INFO - 'config_files': ('talos/linux_config.py',), 11:20:24 INFO - 'default_actions': ('clobber', 11:20:24 INFO - 'read-buildbot-config', 11:20:24 INFO - 'download-and-extract', 11:20:24 INFO - 'populate-webroot', 11:20:24 INFO - 'create-virtualenv', 11:20:24 INFO - 'install', 11:20:24 INFO - 'run-tests'), 11:20:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:24 INFO - 'download_minidump_stackwalk': True, 11:20:24 INFO - 'download_symbols': 'ondemand', 11:20:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:24 INFO - 'installer_path': 'installer.exe', 11:20:24 INFO - 'log_level': 'info', 11:20:24 INFO - 'log_name': 'talos', 11:20:24 INFO - 'log_to_console': True, 11:20:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:24 INFO - 'opt_config_files': (), 11:20:24 INFO - 'pip_index': False, 11:20:24 INFO - 'sps_profile': False, 11:20:24 INFO - 'sps_profile_interval': 0, 11:20:24 INFO - 'suite': 'dromaeojs-e10s', 11:20:24 INFO - 'system_bits': '32', 11:20:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:24 INFO - 'title': 'talos-linux64-ix-041', 11:20:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:24 INFO - 'use_talos_json': True, 11:20:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:24 INFO - 'work_dir': 'build'} 11:20:24 INFO - ##### 11:20:24 INFO - ##### Running clobber step. 11:20:24 INFO - ##### 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: clobber 11:20:24 INFO - rmtree: /builds/slave/test/build 11:20:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:24 INFO - Running post-action listener: _resource_record_post_action 11:20:24 INFO - ##### 11:20:24 INFO - ##### Finished clobber step (success) 11:20:24 INFO - ##### 11:20:24 INFO - ##### 11:20:24 INFO - ##### Running read-buildbot-config step. 11:20:24 INFO - ##### 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: read_buildbot_config 11:20:24 INFO - Using buildbot properties: 11:20:24 INFO - { 11:20:24 INFO - "project": "", 11:20:24 INFO - "product": "firefox", 11:20:24 INFO - "script_repo_revision": "production", 11:20:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:20:24 INFO - "repository": "", 11:20:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:20:24 INFO - "buildid": "20160602083053", 11:20:24 INFO - "pgo_build": "True", 11:20:24 INFO - "basedir": "/builds/slave/test", 11:20:24 INFO - "buildnumber": 523, 11:20:24 INFO - "slavename": "talos-linux64-ix-041", 11:20:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:20:24 INFO - "platform": "ubuntu64_hw", 11:20:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:20:24 INFO - "branch": "fx-team", 11:20:24 INFO - "repo_path": "integration/fx-team", 11:20:24 INFO - "revision": "60b8c047de4c4551de50cb1f088615d49c2370c5", 11:20:24 INFO - "stage_platform": "linux64-pgo", 11:20:24 INFO - "builduid": "34356c4fc4a746598981ec065b23e308", 11:20:24 INFO - "slavebuilddir": "test" 11:20:24 INFO - } 11:20:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:20:24 INFO - Running post-action listener: _resource_record_post_action 11:20:24 INFO - ##### 11:20:24 INFO - ##### Finished read-buildbot-config step (success) 11:20:24 INFO - ##### 11:20:24 INFO - ##### 11:20:24 INFO - ##### Running download-and-extract step. 11:20:24 INFO - ##### 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: download_and_extract 11:20:24 INFO - mkdir: /builds/slave/test/build/tests 11:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:24 INFO - https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:20:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:20:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:20:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:30 INFO - Downloaded 1361 bytes. 11:20:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:20:30 INFO - Using the following test package requirements: 11:20:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:20:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'jsshell-linux-x86_64.zip'], 11:20:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:20:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:20:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:30 INFO - https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:20:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:20:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:20:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:34 INFO - Downloaded 24439748 bytes. 11:20:34 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'] 11:20:34 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 11:20:35 INFO - Return code: 0 11:20:35 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 11:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:35 INFO - https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:42 INFO - Downloaded 24439748 bytes. 11:20:42 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'] 11:20:42 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 11:20:43 INFO - Return code: 0 11:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:43 INFO - https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:45 INFO - Downloaded 10834055 bytes. 11:20:45 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'] 11:20:45 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 11:20:45 INFO - Return code: 0 11:20: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')]} 11:20:45 INFO - https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:20:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:20:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:20:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YJYwIuT9Q7G7r0t4nehGew/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 11:20:46 INFO - Downloaded 59058520 bytes. 11:20:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:20:47 INFO - mkdir: /builds/slave/test/properties 11:20:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:47 INFO - Contents: 11:20:47 INFO - build_url:https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:20:47 INFO - Running post-action listener: _resource_record_post_action 11:20:47 INFO - Running post-action listener: set_extra_try_arguments 11:20:47 INFO - ##### 11:20:47 INFO - ##### Finished download-and-extract step (success) 11:20:47 INFO - ##### 11:20:47 INFO - ##### 11:20:47 INFO - ##### Running populate-webroot step. 11:20:47 INFO - ##### 11:20:47 INFO - Running pre-action listener: _resource_record_pre_action 11:20:47 INFO - Running main action method: populate_webroot 11:20:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:47 INFO - '--tppagecycles', 11:20:47 INFO - '7'], 11:20:47 INFO - 'tests': ['tsvgm']}}, 11:20:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['damp', 'tps']}, 11:20:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'tests': ['damp', 'tps']}, 11:20:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['dromaeo_dom']}, 11:20:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['a11yr', 11:20:47 INFO - 'ts_paint', 11:20:47 INFO - 'tpaint', 11:20:47 INFO - 'sessionrestore', 11:20:47 INFO - 'sessionrestore_no_auto_restore', 11:20:47 INFO - 'tabpaint']}, 11:20:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:47 INFO - 'ts_paint', 11:20:47 INFO - 'tpaint', 11:20:47 INFO - 'sessionrestore', 11:20:47 INFO - 'sessionrestore_no_auto_restore', 11:20:47 INFO - 'tabpaint']}, 11:20:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:47 INFO - 'ts_paint', 11:20:47 INFO - 'tpaint', 11:20:47 INFO - 'sessionrestore', 11:20:47 INFO - 'sessionrestore_no_auto_restore', 11:20:47 INFO - 'tabpaint']}, 11:20:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:47 INFO - 'ts_paint', 11:20:47 INFO - 'tpaint', 11:20:47 INFO - 'sessionrestore', 11:20:47 INFO - 'sessionrestore_no_auto_restore', 11:20:47 INFO - 'tabpaint']}, 11:20:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['a11yr', 11:20:47 INFO - 'ts_paint', 11:20:47 INFO - 'tpaint', 11:20:47 INFO - 'sessionrestore', 11:20:47 INFO - 'sessionrestore_no_auto_restore', 11:20:47 INFO - 'tabpaint']}, 11:20:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['a11yr', 11:20:47 INFO - 'ts_paint', 11:20:47 INFO - 'tpaint', 11:20:47 INFO - 'sessionrestore', 11:20:47 INFO - 'sessionrestore_no_auto_restore', 11:20:47 INFO - 'tabpaint']}, 11:20:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['tsvgx', 11:20:47 INFO - 'tsvgr_opacity', 11:20:47 INFO - 'tart', 11:20:47 INFO - 'tscrollx', 11:20:47 INFO - 'cart']}, 11:20:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:47 INFO - 'tsvgr_opacity', 11:20:47 INFO - 'tart', 11:20:47 INFO - 'tscrollx', 11:20:47 INFO - 'cart']}, 11:20:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'talos_options': ['--disable-e10s'], 11:20:47 INFO - 'tests': ['tp5o']}, 11:20:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'tests': ['tp5o']}, 11:20:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'talos_options': ['--disable-e10s', 11:20:47 INFO - '--xperf_path', 11:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:47 INFO - 'tests': ['tp5n']}, 11:20:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:47 INFO - 'talos_options': ['--xperf_path', 11:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:47 INFO - 'tests': ['tp5n']}}, 11:20:47 INFO - 'talos.zip': {'path': '', 11:20:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:47 INFO - Running post-action listener: _resource_record_post_action 11:20:47 INFO - ##### 11:20:47 INFO - ##### Finished populate-webroot step (success) 11:20:47 INFO - ##### 11:20:47 INFO - ##### 11:20:47 INFO - ##### Running create-virtualenv step. 11:20:47 INFO - ##### 11:20:47 INFO - Running pre-action listener: _resource_record_pre_action 11:20:47 INFO - Running main action method: create_virtualenv 11:20:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:47 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 11:20:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:47 INFO - Using real prefix '/usr' 11:20:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:50 INFO - Installing pip.................done. 11:20:50 INFO - Return code: 0 11:20:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:50 INFO - Using env: {'DISPLAY': ':0', 11:20:50 INFO - 'HOME': '/home/cltbld', 11:20:50 INFO - 'LANG': 'en_US.UTF-8', 11:20:50 INFO - 'LANGUAGE': 'en_US:en', 11:20:50 INFO - 'LOGNAME': 'cltbld', 11:20:50 INFO - 'MAIL': '/var/mail/cltbld', 11:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:50 INFO - 'MOZ_NO_REMOTE': '1', 11:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:50 INFO - 'NO_EM_RESTART': '1', 11:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:50 INFO - 'PWD': '/builds/slave/test', 11:20:50 INFO - 'SHELL': '/bin/bash', 11:20:50 INFO - 'SHLVL': '1', 11:20:50 INFO - 'TERM': 'linux', 11:20:50 INFO - 'TMOUT': '86400', 11:20:50 INFO - 'USER': 'cltbld', 11:20:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:50 INFO - '_': '/tools/buildbot/bin/python'} 11:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:50 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 11:20:50 INFO - Cleaning up... 11:20:50 INFO - Return code: 0 11:20:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:50 INFO - Using env: {'DISPLAY': ':0', 11:20:50 INFO - 'HOME': '/home/cltbld', 11:20:50 INFO - 'LANG': 'en_US.UTF-8', 11:20:50 INFO - 'LANGUAGE': 'en_US:en', 11:20:50 INFO - 'LOGNAME': 'cltbld', 11:20:50 INFO - 'MAIL': '/var/mail/cltbld', 11:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:50 INFO - 'MOZ_NO_REMOTE': '1', 11:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:50 INFO - 'NO_EM_RESTART': '1', 11:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:50 INFO - 'PWD': '/builds/slave/test', 11:20:50 INFO - 'SHELL': '/bin/bash', 11:20:50 INFO - 'SHLVL': '1', 11:20:50 INFO - 'TERM': 'linux', 11:20:50 INFO - 'TMOUT': '86400', 11:20:50 INFO - 'USER': 'cltbld', 11:20:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:50 INFO - '_': '/tools/buildbot/bin/python'} 11:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:50 INFO - Downloading/unpacking psutil>=3.1.1 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:52 INFO - Installing collected packages: psutil 11:20:52 INFO - Running setup.py install for psutil 11:20:52 INFO - building 'psutil._psutil_linux' extension 11:20:52 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 11:20:53 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 11:20:53 INFO - building 'psutil._psutil_posix' extension 11:20:53 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 11:20:53 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 11:20:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:53 INFO - Successfully installed psutil 11:20:53 INFO - Cleaning up... 11:20:53 INFO - Return code: 0 11:20:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:53 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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:20:53 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 11:20:53 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 11:20:53 INFO - Using env: {'DISPLAY': ':0', 11:20:53 INFO - 'HOME': '/home/cltbld', 11:20:53 INFO - 'LANG': 'en_US.UTF-8', 11:20:53 INFO - 'LANGUAGE': 'en_US:en', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MAIL': '/var/mail/cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SHLVL': '1', 11:20:53 INFO - 'TERM': 'linux', 11:20:53 INFO - 'TMOUT': '86400', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:55 INFO - Installing collected packages: mozsystemmonitor 11:20:55 INFO - Running setup.py install for mozsystemmonitor 11:20:55 INFO - Successfully installed mozsystemmonitor 11:20:55 INFO - Cleaning up... 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:55 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')]} 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 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')]} 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:20:55 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 11:20:55 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 11:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:55 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 11:20:55 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 11:20:55 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 11:20:55 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 11:20:55 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 11:20:55 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 11:20:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - Downloading docopt-0.6.1.tar.gz 11:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:58 INFO - Running setup.py install for blobuploader 11:20:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:58 INFO - Running setup.py install for requests 11:20:59 INFO - Running setup.py install for docopt 11:20:59 INFO - Successfully installed blobuploader requests docopt 11:20:59 INFO - Cleaning up... 11:20:59 INFO - Return code: 0 11:20:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:59 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')]} 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:59 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')]} 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:59 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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:20:59 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 11:20:59 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 11:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:59 INFO - Running setup.py (path:/tmp/pip-KXF6K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:59 INFO - Running setup.py (path:/tmp/pip-mOw4lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:59 INFO - Running setup.py (path:/tmp/pip-wUeaQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:59 INFO - Running setup.py (path:/tmp/pip-Qj1VFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:59 INFO - Running setup.py (path:/tmp/pip-cVkpWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:59 INFO - Running setup.py (path:/tmp/pip-Ydwgbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:59 INFO - Running setup.py (path:/tmp/pip-eYAmv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:59 INFO - Running setup.py (path:/tmp/pip-rbYbK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:59 INFO - Running setup.py (path:/tmp/pip-H8hOeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:00 INFO - Running setup.py (path:/tmp/pip-MXtKuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:00 INFO - Running setup.py (path:/tmp/pip-8bcX5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:00 INFO - Running setup.py (path:/tmp/pip-95V8jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:00 INFO - Running setup.py (path:/tmp/pip-oQbTx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:00 INFO - Running setup.py (path:/tmp/pip-fkgv7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:00 INFO - Running setup.py (path:/tmp/pip-JcLeP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:00 INFO - Running setup.py (path:/tmp/pip-WoqcZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:00 INFO - Running setup.py (path:/tmp/pip-TsvefA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:00 INFO - Running setup.py install for manifestparser 11:21:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozcrash 11:21:00 INFO - Running setup.py install for mozdebug 11:21:00 INFO - Running setup.py install for mozdevice 11:21:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozfile 11:21:01 INFO - Running setup.py install for mozhttpd 11:21:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozinfo 11:21:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozInstall 11:21:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozleak 11:21:01 INFO - Running setup.py install for mozlog 11:21:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for moznetwork 11:21:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozprocess 11:21:01 INFO - Running setup.py install for mozprofile 11:21:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozrunner 11:21:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Running setup.py install for mozscreenshot 11:21:02 INFO - Running setup.py install for moztest 11:21:02 INFO - Running setup.py install for mozversion 11:21:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:02 INFO - Cleaning up... 11:21:02 INFO - Return code: 0 11:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:02 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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:21:02 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 11:21:02 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 11:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Running setup.py (path:/tmp/pip-vuWVaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 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)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 INFO - Running setup.py (path:/tmp/pip-Q2Lh69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 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)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 INFO - Running setup.py (path:/tmp/pip-cYCm_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 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)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 INFO - Running setup.py (path:/tmp/pip-FWCpjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 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)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:02 INFO - Running setup.py (path:/tmp/pip-hOjW4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:03 INFO - Running setup.py (path:/tmp/pip-SQWWl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:03 INFO - Running setup.py (path:/tmp/pip-UyjAD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:03 INFO - Running setup.py (path:/tmp/pip-RB7bq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:03 INFO - Running setup.py (path:/tmp/pip-ZtEGFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:03 INFO - Running setup.py (path:/tmp/pip-1ByCsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 INFO - Running setup.py (path:/tmp/pip-Ff_FGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 INFO - Running setup.py (path:/tmp/pip-ogbBJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 INFO - Running setup.py (path:/tmp/pip-93Humn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 INFO - Running setup.py (path:/tmp/pip-N7GT7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 INFO - Running setup.py (path:/tmp/pip-iGvCo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:03 INFO - Running setup.py (path:/tmp/pip-hmmblB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:03 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)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:03 INFO - Running setup.py (path:/tmp/pip-1gM7ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:03 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)) 11:21:03 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)) 11:21:03 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)) 11:21:03 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)) 11:21:03 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)) 11:21:03 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)) 11:21:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:21:05 INFO - Downloading blessings-1.6.tar.gz 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:05 INFO - Installing collected packages: blessings 11:21:05 INFO - Running setup.py install for blessings 11:21:05 INFO - Successfully installed blessings 11:21:05 INFO - Cleaning up... 11:21:06 INFO - Return code: 0 11:21:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:06 INFO - Reading from file tmpfile_stdout 11:21:06 INFO - Current package versions: 11:21:06 INFO - argparse == 1.2.1 11:21:06 INFO - blessings == 1.6 11:21:06 INFO - blobuploader == 1.2.4 11:21:06 INFO - docopt == 0.6.1 11:21:06 INFO - manifestparser == 1.1 11:21:06 INFO - mozInstall == 1.12 11:21:06 INFO - mozcrash == 0.17 11:21:06 INFO - mozdebug == 0.1 11:21:06 INFO - mozdevice == 0.48 11:21:06 INFO - mozfile == 1.2 11:21:06 INFO - mozhttpd == 0.7 11:21:06 INFO - mozinfo == 0.9 11:21:06 INFO - mozleak == 0.1 11:21:06 INFO - mozlog == 3.2 11:21:06 INFO - moznetwork == 0.27 11:21:06 INFO - mozprocess == 0.22 11:21:06 INFO - mozprofile == 0.28 11:21:06 INFO - mozrunner == 6.11 11:21:06 INFO - mozscreenshot == 0.1 11:21:06 INFO - mozsystemmonitor == 0.3 11:21:06 INFO - moztest == 0.7 11:21:06 INFO - mozversion == 1.4 11:21:06 INFO - psutil == 3.1.1 11:21:06 INFO - requests == 1.2.3 11:21:06 INFO - wsgiref == 0.1.2 11:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:06 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')]} 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:06 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')]} 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:06 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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:21:06 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 11:21:06 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 11:21:06 INFO - Using env: {'DISPLAY': ':0', 11:21:06 INFO - 'HOME': '/home/cltbld', 11:21:06 INFO - 'LANG': 'en_US.UTF-8', 11:21:06 INFO - 'LANGUAGE': 'en_US:en', 11:21:06 INFO - 'LOGNAME': 'cltbld', 11:21:06 INFO - 'MAIL': '/var/mail/cltbld', 11:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:06 INFO - 'MOZ_NO_REMOTE': '1', 11:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:06 INFO - 'NO_EM_RESTART': '1', 11:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:06 INFO - 'PWD': '/builds/slave/test', 11:21:06 INFO - 'SHELL': '/bin/bash', 11:21:06 INFO - 'SHLVL': '1', 11:21:06 INFO - 'TERM': 'linux', 11:21:06 INFO - 'TMOUT': '86400', 11:21:06 INFO - 'USER': 'cltbld', 11:21:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:06 INFO - '_': '/tools/buildbot/bin/python'} 11:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 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)) 11:21:06 INFO - Cleaning up... 11:21:06 INFO - Return code: 0 11:21:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:06 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')]} 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:06 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')]} 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:06 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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:21:06 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 11:21:06 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 11:21:06 INFO - Using env: {'DISPLAY': ':0', 11:21:06 INFO - 'HOME': '/home/cltbld', 11:21:06 INFO - 'LANG': 'en_US.UTF-8', 11:21:06 INFO - 'LANGUAGE': 'en_US:en', 11:21:06 INFO - 'LOGNAME': 'cltbld', 11:21:06 INFO - 'MAIL': '/var/mail/cltbld', 11:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:06 INFO - 'MOZ_NO_REMOTE': '1', 11:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:06 INFO - 'NO_EM_RESTART': '1', 11:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:06 INFO - 'PWD': '/builds/slave/test', 11:21:06 INFO - 'SHELL': '/bin/bash', 11:21:06 INFO - 'SHLVL': '1', 11:21:06 INFO - 'TERM': 'linux', 11:21:06 INFO - 'TMOUT': '86400', 11:21:06 INFO - 'USER': 'cltbld', 11:21:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:06 INFO - '_': '/tools/buildbot/bin/python'} 11:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:06 INFO - Downloading/unpacking jsonschema 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:08 INFO - Downloading/unpacking functools32 (from jsonschema) 11:21:08 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 11:21:08 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 11:21:08 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 11:21:08 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 11:21:08 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 11:21:08 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 11:21:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:08 INFO - warning: no files found matching '*.txt' 11:21:08 INFO - no previously-included directories found matching 'build' 11:21:08 INFO - no previously-included directories found matching 'dist' 11:21:08 INFO - no previously-included directories found matching '.git*' 11:21:08 INFO - Installing collected packages: jsonschema, functools32 11:21:08 INFO - Running setup.py install for functools32 11:21:08 INFO - warning: no files found matching '*.txt' 11:21:08 INFO - no previously-included directories found matching 'build' 11:21:08 INFO - no previously-included directories found matching 'dist' 11:21:08 INFO - no previously-included directories found matching '.git*' 11:21:08 INFO - Successfully installed jsonschema functools32 11:21:08 INFO - Cleaning up... 11:21:09 INFO - Return code: 0 11:21:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:09 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 0x7fcdcf971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', '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 11:21:09 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 11:21:09 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 11:21:09 INFO - Using env: {'DISPLAY': ':0', 11:21:09 INFO - 'HOME': '/home/cltbld', 11:21:09 INFO - 'LANG': 'en_US.UTF-8', 11:21:09 INFO - 'LANGUAGE': 'en_US:en', 11:21:09 INFO - 'LOGNAME': 'cltbld', 11:21:09 INFO - 'MAIL': '/var/mail/cltbld', 11:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:09 INFO - 'MOZ_NO_REMOTE': '1', 11:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:09 INFO - 'NO_EM_RESTART': '1', 11:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:09 INFO - 'PWD': '/builds/slave/test', 11:21:09 INFO - 'SHELL': '/bin/bash', 11:21:09 INFO - 'SHLVL': '1', 11:21:09 INFO - 'TERM': 'linux', 11:21:09 INFO - 'TMOUT': '86400', 11:21:09 INFO - 'USER': 'cltbld', 11:21:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:09 INFO - '_': '/tools/buildbot/bin/python'} 11:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:09 INFO - Downloading/unpacking flake8 11:21:09 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 11:21:09 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 11:21:09 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 11:21:09 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 11:21:09 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 11:21:09 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 11:21:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:21:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:21:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 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 11:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:21:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:21:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:21:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:21:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:21:11 INFO - no previously-included directories found matching 'docs/_build' 11:21:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:21:11 INFO - Running setup.py install for pep8 11:21:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:21:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:21:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:21:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:21:11 INFO - no previously-included directories found matching 'docs/_build' 11:21:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:21:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:21:11 INFO - Cleaning up... 11:21:12 INFO - Return code: 0 11:21:12 INFO - Running post-action listener: _resource_record_post_action 11:21:12 INFO - Running post-action listener: _start_resource_monitoring 11:21:12 INFO - Starting resource monitoring. 11:21:12 INFO - ##### 11:21:12 INFO - ##### Finished create-virtualenv step (success) 11:21:12 INFO - ##### 11:21:12 INFO - ##### 11:21:12 INFO - ##### Running install step. 11:21:12 INFO - ##### 11:21:12 INFO - Running pre-action listener: _resource_record_pre_action 11:21:12 INFO - Running main action method: install 11:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:12 INFO - Reading from file tmpfile_stdout 11:21:12 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:12 INFO - Reading from file tmpfile_stdout 11:21:12 INFO - Output received: 11:21:12 INFO - Usage: mozinstall [options] installer 11:21:12 INFO - Options: 11:21:12 INFO - -h, --help show this help message and exit 11:21:12 INFO - -d DEST, --destination=DEST 11:21:12 INFO - Directory to install application into. [default: 11:21:12 INFO - "/builds/slave/test"] 11:21:12 INFO - --app=APP Application being installed. [default: firefox] 11:21:12 INFO - mkdir: /builds/slave/test/build/application 11:21:12 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'] 11:21:12 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 11:21:29 INFO - Reading from file tmpfile_stdout 11:21:29 INFO - Output received: 11:21:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:29 INFO - Running post-action listener: _resource_record_post_action 11:21:29 INFO - ##### 11:21:29 INFO - ##### Finished install step (success) 11:21:29 INFO - ##### 11:21:29 INFO - ##### 11:21:29 INFO - ##### Running run-tests step. 11:21:29 INFO - ##### 11:21:29 INFO - Running pre-action listener: _resource_record_pre_action 11:21:29 INFO - Running main action method: run_tests 11:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:29 INFO - Python 2.7.3 11:21:29 INFO - Return code: 0 11:21:29 INFO - grabbing minidump binary from tooltool 11:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:29 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 0x1d0c9c0>, '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 0x1d0d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:29 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 11:21:29 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 11:21:29 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 11:21:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:29 INFO - Return code: 0 11:21:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:21:30 INFO - Return code: 0 11:21:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:30 INFO - Using env: {'DISPLAY': ':0', 11:21:30 INFO - 'HOME': '/home/cltbld', 11:21:30 INFO - 'LANG': 'en_US.UTF-8', 11:21:30 INFO - 'LANGUAGE': 'en_US:en', 11:21:30 INFO - 'LOGNAME': 'cltbld', 11:21:30 INFO - 'MAIL': '/var/mail/cltbld', 11:21:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:30 INFO - 'MOZ_NO_REMOTE': '1', 11:21:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:30 INFO - 'NO_EM_RESTART': '1', 11:21:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:30 INFO - 'PWD': '/builds/slave/test', 11:21:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:30 INFO - 'SHELL': '/bin/bash', 11:21:30 INFO - 'SHLVL': '1', 11:21:30 INFO - 'TERM': 'linux', 11:21:30 INFO - 'TMOUT': '86400', 11:21:30 INFO - 'USER': 'cltbld', 11:21:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992', 11:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:30 INFO - '_': '/tools/buildbot/bin/python'} 11:21:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:30 INFO - mozversion application_buildid: 20160602083053 11:21:30 INFO - mozversion application_changeset: 60b8c047de4c4551de50cb1f088615d49c2370c5 11:21:30 INFO - mozversion application_display_name: Nightly 11:21:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:30 INFO - mozversion application_name: Firefox 11:21:30 INFO - mozversion application_remotingname: firefox 11:21:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:21:30 INFO - mozversion application_vendor: Mozilla 11:21:30 INFO - mozversion application_version: 49.0a1 11:21:30 INFO - mozversion platform_buildid: 20160602083053 11:21:30 INFO - mozversion platform_changeset: 60b8c047de4c4551de50cb1f088615d49c2370c5 11:21:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:21:30 INFO - mozversion platform_version: 49.0a1 11:21:30 INFO - using testdate: 1464891690 11:21:30 INFO - actual date: 1464891690 11:21:30 INFO - starting webserver on 'localhost:59845' 11:21:30 INFO - SUITE-START | Running 2 tests 11:21:30 INFO - TEST-START | dromaeo_css 11:21:30 INFO - operating with platform_type : linux_ 11:21:30 INFO - Initialising browser for dromaeo_css test... 11:21:30 INFO - TEST-INFO | started process 23301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Y7GsN/profile http://localhost:59845/getInfo.html) 11:21:35 INFO - PROCESS | 23301 | __metrics Screen width/height:1600/1200 11:21:35 INFO - PROCESS | 23301 | colorDepth:24 11:21:35 INFO - PROCESS | 23301 | Browser inner width/height: 1024/697 11:21:35 INFO - PROCESS | 23301 | __metrics 11:21:35 ERROR - PROCESS | 23301 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:21:36 INFO - TEST-INFO | 23301: exit 0 11:21:36 INFO - Browser initialized. 11:21:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:36 INFO - TEST-INFO | started process 23421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Y7GsN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:48 INFO - PROCESS | 23421 | RSS: Main: 167403520 11:21:48 INFO - PROCESS | 23421 | 11:22:38 INFO - PROCESS | 23421 | 1464891758221 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] 11:24:45 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:59845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59845/tests/dromaeo/cssquery-ext.html) 11:24:46 INFO - PROCESS | 23421 | RSS: Main: 170680320 11:24:46 INFO - PROCESS | 23421 | 11:27:48 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:59845/tests/dromaeo/cssquery-ext.html (next: http://localhost:59845/tests/dromaeo/cssquery-jquery.html) 11:27:49 INFO - PROCESS | 23421 | RSS: Main: 170008576 11:27:49 INFO - PROCESS | 23421 | 11:30:51 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:59845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59845/tests/dromaeo/cssquery-mootools.html) 11:30:51 INFO - PROCESS | 23421 | RSS: Main: 170704896 11:30:51 INFO - PROCESS | 23421 | 11:33:53 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:59845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59845/tests/dromaeo/cssquery-prototype.html) 11:33:54 INFO - PROCESS | 23421 | RSS: Main: 168050688 11:33:54 INFO - PROCESS | 23421 | 11:36:56 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:59845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59845/tests/dromaeo/cssquery-yui.html) 11:36:57 INFO - PROCESS | 23421 | RSS: Main: 169623552 11:36:57 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | Cycle 1(1): loaded http://localhost:59845/tests/dromaeo/cssquery-yui.html (next: http://localhost:59845/tests/dromaeo/cssquery-dojo.html) 11:40:00 INFO - PROCESS | 23421 | RSS: Main: 171073536 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | __start_tp_report 11:40:00 INFO - PROCESS | 23421 | _x_x_mozilla_page_load 11:40:00 INFO - PROCESS | 23421 | _x_x_mozilla_page_load_details 11:40:00 INFO - PROCESS | 23421 | |i|pagename|runs| 11:40:00 INFO - PROCESS | 23421 | |0;dojo.html;3095.349976504934;3144.402563512931;3176.6823317668236;3186.426443240216;3187.171335452783;5383.9461605383985;5437.102878025126;5463.972680136599;5494.890102197954;5551.833444996647;5380.784768609251;5439.673619582828;5486.451354864522;5502.972485137579;5611.270534830476;4929.112759703261;4965.801367945278;5062.417821950467;5113.1052065888325;5179.766910489037;810.7019513407438;4962.751862406883;5111.412187598418;5156.355455568054;5195.558377537914;5046.949530504721;5074.644774865761;5096.006278775641;5097.388313402397;5131.1277082895995;4980.850574482772;5084;5084.339035925343;5099.311592934943;5111.974440127776;5000.224965130411;5088.2622019807295;5091.312672789163;5096.337476128117;5141.30592370029;5496.285482887239;5535.418781028015;5551.3893471718075;5552.5280351170195;5552.750126244328;5709.543236541067;5768.42315768424;5773.8556536086935;5983.640981541122;5987.191729116601;5860.472557469806;5870.706464676792;5882.3823498532465;5897.292324921037;5949.613275137102;5472.425395333473;5499.890002199933;5519.089350257243;5519.917201241944;5520.613557051008;5760.452756988079;5822.767089316465;5828.242328497353;5908.940910590839;6008.068749343859;5678.063119585305;5736.110902809987;5847.473727364558;5869.119632055226;5895;5923.644581325048;5955.285365756137;5964.075568286922;5967.880642387128;5986.431289027535;5704.458076482728;5954.672493012839;5955.79154729591;5957.582969192202;5968;5937.465628093492;6016.729247183887;6041.667708275999;6045.818625441244;6097.085437184458;4507.391502147234;4509.571590698878;4515.458145022552;4524.457065152203;4562.315652652062;3912.374020156761;3980.164165525272;4007.979960100181;4051.4125451809323;4080.2043601498017;5693.373728889819;5712.914306285409;5725.912076705413;5740.339860916049;5781.277340332458;5921.822345329647;5956.434138756811;6010.489108425745;6012.969935150296;6013.248343957005;5568.972155139199;5599.356074051455;5638.2670252866865;5707.143928410772;5719.571032172604;5105.361829771278;5136.383633963948;5139.614528910347;5145.382554093533;5186.299849520342;6200;6206.937930620727;6208.782692605737;6212.782552610637;6224.813255602339;5648.8305350840365;5947.197128387612;5980.282366116094;5980.671063091398;5995.490383317379;6147.938520614736;6194.090133934475;6231.314555398993;6237.906431403442;6275.874482510416;5911.497522710618;5912.73392697321;5925.555583331354;5940.79207227745;5960.0761881908375;5734.913976290442;5817.185594016756;5968.612040217372;5970.9701451492465;5996.790112346047;5697.971510142423;5705.942940570541;5717.971410142923;5721.914171287351;5722.799702010409;5695.686737229492;5715.542756579547;5719.48524632785;5725.828225153252;5761.654300741969;5521.834344969658;5717.885642287214;5734.34055083654;5770;5779;5868.530517558671;5891.204687367322;5913.70431478433;5934.9109763354445;5938.940610593839;5434.076207044733;5761.164631128547;5763.7982670606325;5765.711714414347;5780.537556995514 11:40:00 INFO - PROCESS | 23421 | |1;ext.html;566.7024811973713;614.7571709174877;631.6967855429391;636.5003472274266;637.6907200007995;32816.83591582042;35619.28761424773;43291.99999999996;44359.33460998088;44459.77770111153;45418.545814541845;46143;46299.53700462994;46346.30480542786;46654.76672616632;8767.47395156291;8858.29133669305;8919.554022298858;8936.597853096593;8946.568549032156;8740.8688869667;8889.68886088987;8919.687810926618;8926.86609700855;8948.06045365237;8903.55482225886;8973.28213742899;9013.729588112366;9027.638894444215;9027.638894444248;8919.598618062171;8935.927688677335;8956.283497320199;8967.775805604846;8993.460392376413;8799.252063574604;8934.597943092576;8936.821263574757;8954.86567701485;8995.415298005608;42021.36967945483;42760;43079;43103.35344969828;43146.56853431457;3297.2086699192023;3341.3818443588016;3442;3452.4130897747445;3530.9646903530893;29974;32737.836310818533;32800;32930;33046;4338.305871060616;4497.325401189815;4519.977400113011;4565.223911934946;4589.839355622571;339265;339510;340941.9999999975;341466;341537;60879;61279.77440451255;61392;61524.69237653783;61781;63761.36238637554;64797;64825;64841;65017.34982650113;14889.851101489063;15151;15293.847061529465;15500.147491888054;15646.295916683777;11525.366104864146;11576;11606.477708503138;11629.47667354971;11679.766404671858;20108.195672172948;20168.394948151577;20356.389308320773;20390.28633997803;20477.692834607493;7190.460715446363;7460.85078298431;7506.099268087864;7567.886481702779;7611.923880761122;916.9403988740711;1045.0959919669583;1046.706922061824;1156.4275683536703;1238.7398646284382;32803.67196328006;33147.66852331494;33377.3324533508;33385.83307083449;33897.830510847285;1101.5979167603766;1144.9370284634258;1210.5944508589546;1213.3266037349356;1221.0414824362833;16620.418285359956;17055.744163837553;17070.23183956725;17199.828001719823;17259.22333494996;525027;528702;529001;535987;536098;58262;59158;59253.703731481066;59363;59407.40592594105;1354.7764618837978;1396.3297617143828;1410.9082909610843;1414.3918115210352;1416.5608661315025;30501.54247686242;31673;31694.683053169174;31891.840540798075;32251.354972899942;49981;50449.49550504448;50493.49506504888;50523.74738126286;50559.49440505548;445164;455716;456923;457221;458789;28294.292642683275;28994.275143120747;29064.418711626073;29076;29085.85457072701;48354;49327.753361232964;49401.737420094665;49662.50337496724;50513;40256.79871600623;42096.3685544711;42696;42970.35544466898;43063.56936430721;42061;42142.789286053376;42146.57853421549;42507.7874610625;42700.78649606732;42227.788861055495;42345.576544234165;42682.5731742691;42998.35502467528;43167.13665726605;35154.64845351514;38130.42804357992;38436.61563384331;38469.61530384772;38714.80642596769;28579;28830.135095947157;28991.710082898902;29257.414851702422;29372.11883643494 11:40:00 INFO - PROCESS | 23421 | |2;jquery.html;402.9456023436837;405.36155555000846;406.9165821006694;411.7570633326337;415.74016239850096;18126.27494900204;19046.333378331725;19716.901415492903;20167.59664806703;20214.09036593353;18266.360677376295;18476.81523184768;18904;19156.521086972833;19226.903865480654;5479.479449452296;5514.641548299368;5716.685582292972;5723.828285151431;5733.168690539869;5588.608797384185;5610.803621873235;5617.297837770278;5627.859303517424;5634.126710359901;5537;5540.113581826909;5611.102223644218;5637.548996080303;5680.403557626451;5588.636738611997;5611.438856114397;5620.072688006474;5635.3237611486475;5656.179853921179;4960.280759289883;5079;5094.694318340911;5105.106606343912;5135.64050516464;21438.249661261936;22226.44433889166;22252.443688907908;22951.54096918069;22977.195798147153;2271.3299576624936;2275.8520696154696;2292.6904867842795;2364.2220391040632;2411.2645643078854;14138.858611413858;14367.568972930725;14440.638984025378;14530.92734536331;14541.636459088502;1931.3240365871973;1935.8935258560773;2015.5465020370445;2047.4471892589067;2054.8356131509595;75094.62452687701;77495;77591.99999999943;77978.22021779823;78799;10523.579056837641;10652.680419587425;10938.617148399768;11069.612563560237;11098;15037.398504059935;15198.772018419733;15229.543113706606;15244.085354878744;15277.847221527865;7767.18444563324;8052.355811535063;8128.349732021424;8137.471064380797;8227.382946279053;7703.6918523259565;7741.225877412214;7758.138046868824;7798.961005194938;7877.724279650185;6630.867382652416;6671.366220209073;6724.9327506725285;6729.937878265378;6771.966140169267;1862.7764668239897;1926.589935813602;1928.4021953194554;1961.5586493039236;1967.4589487890944;917.8210249001514;1004.1314263162312;1017.4709151241461;1045.095991966943;1123.3767206386856;19020.61958760817;19611.117499712545;19618.215271388985;19830.801691983183;19933.900330498254;1031.51003273446;1032.339302846179;1036.533559898049;1082.426314053553;1130.7681925205313;10664.893351066545;11279.548818047351;11282.717932051764;11290.379029153311;11351.489182986785;453580;455529;457090;490318;497939;49058.50941490539;76595.61702191453;79973.60013200014;82224.58887705523;84478.15521844826;1034.1519953637944;1035.409816404642;1043.7234132954773;1054.1777413617237;1065.195777188218;16883.240254188346;16980.660386791948;17390.391336303168;17573.912130439778;17787.644247115244;30757;37985.81007094947;39247.41128883126;39759.60240397559;40758.1848363037;51007;52299.47700522946;52805.47194528006;52855.73572132115;52953.7352313236;7580.810479738051;7878.606069696607;8095.878561821695;8474.872876906727;9073.45559266446;10072;13501.72996540044;13511.324433778074;13863.722725545635;13931.512397066459;11865.288082715064;11965.581204657796;12007.75984480288;12063.81904271419;12088.818667720167;11687.163009639116;11695.473703683185;11877.82183267269;11881.227720198505;12222.877771222174;11764.764704706029;11768.293902365886;12104.636860894187;12195.75608487843;12470.314132722788;8006.599670016592;8026.919730802851;8043.798905027421;8076.71731489395;8140.918590814016;11494.252873563191;12099.879001209874;12119.212251203644;12227.572034978733;12262.87737122653 11:40:00 INFO - PROCESS | 23421 | |3;mootools.html;1503.0831192972284;1525.5652139140343;1693.6358682883179;1799.7660304160456;1829.5334689654144;7976.92023079769;8328.45865018775;8608.483490990537;9200.1719845214;9201.539923003847;8621.913780862189;8667.13328667133;8700.651973921036;8726.258268047208;8763.298936085113;2232.274510783998;2252.4594097416584;2265.105283413051;2265.5129147233342;2272.1820144747876;2213.6347502662043;2223.7442694090146;2265.6148454762647;2265.8527195732227;2265.9660105098355;2245.236619549353;2247.83141264405;2251.0883092347544;2256.3343813575034;2263.818894488437;2208.6134926387817;2209.2488553891594;2230.6877037214804;2236.2955668964305;2237.183428048767;2094.0786054136283;2104.4738815296178;2107.2729908181655;2109.08254909115;2111.1660893946805;8573.699920502753;8633.740987770314;8656.177663121993;8658.090900455487;8679.43583667066;5290.55030322423;5417.810376636839;5424.376196737387;5437;5452.482014208644;3190.601174853143;3276.918077048093;3394.117529442338;3396.677315655009;3418.060033490785;1112.3603927741501;1140.634996801024;1161.9360935148563;1162.7441962768178;1171.5138217639756;12882.227066376048;12914.87085129146;12939;12940.741185176244;12956.352182390938;4710.26990816424;4714.693544919638;4816.927746083811;4828.2998965150555;4926.211806111005;10539;10560.155187584975;10579.523921423555;10583.894161058444;10587.311824731369;5349.893002139936;5427.294451721251;5439.564834813205;5452.291202143775;5464.26232458621;4354.608085272341;4689.648276379286;4830.516948305141;4993.7503124843615;5007.899842003212;4111.588841115924;4144.659443867373;4199.139176468817;4212.220739163265;4271.124419493996;1312.744014917082;1333.2267284974691;1337.4182230729664;1338.6118025772612;1342.536824795444;816.8652172391608;819.9754007379788;918.8621706743908;933.4725879877848;938.5494962418078;5826.0678291474005;5838.649681019152;5882.088276317178;6046.606970546901;6059.454649081604;447.6351773304746;452.2515237282303;452.9501754806969;951.7002144324516;1037.6523864505325;3775.244951009809;3839.212961342918;3846.576876543578;3867.497225360685;3880.495535580413;10950.452477376099;11153;11165.888341116648;11250.381229032482;11262.605808796652;10812.405317707444;11163.106951443864;11174.27367221128;11183.72040698989;11226.831597525881;8308.459950103224;8312.709055183039;8334.541600212047;8419.284360829275;8435.957820210982;5748.856278593069;5764.279465066867;5870.26621672291;5898.646081234968;5934.662176571713;10057.145142662956;10260.743481413025;10281.12610428122;10304.845427318447;10406.791864162826;9698.56356463975;10112.08991190767;10182.796344073226;10259.897401025893;10322.48387580633;7778.031378075104;7850.0972388173805;7956.761297161094;7970.4022198336515;7978.640961156646;8292.253697167283;8356.498610083414;8375.706850260212;8390.538520381439;8396.832063358577;7482.513636613603;7618.123915749759;7703.576303303372;7786.571738554434;7839.216078392115;7384.889226661497;7451.180370159386;7474.663640136316;7549.50928189666;7553.357964573072;6923.861522769617;6954.687039083355;6974.68613912365;6997.1253593300835;7007.754728584475;4956.975215123901;5053.444121146597;5072.264521644414;5173.560247378864;5179.896402071862;5170.974145129401;5172.948270517397;5212.765425555935;5285.312909321764;5297.470252974672 11:40:00 INFO - PROCESS | 23421 | |4;prototype.html;335.39346530120724;342.3119529745212;344.7104432276887;348.59040627262976;354.765854536006;5531.889362212758;5537.750801213945;5581.5255703265275;5610.438956104393;5627.818158186776;5523.585731070176;5529.557635389169;5532.806351777688;5560.944390556093;5620.606557540974;4138.565450627686;4362.5637436256275;4371.67204467578;4405.207062728708;4432.15789000089;4218.881996270975;4369.912601747963;4377.277749171383;4406;4412.47050353958;4323.935140972888;4329.826806927719;4337.436133302666;4339.956600434002;4390.319500477415;4306.0526684129445;4372.584604462571;4383.824647014116;4389.23188442023;4403.9559604404185;3867.361885288924;3867.671247943928;3869.361555343365;3877.592852750477;3886.24218277436;5302.840914772563;5363.919541206885;5369.301990741218;5371.892562148735;5391.245225668409;4972.254161875711;5007.148784706572;5014.824481143142;5016.372953380827;5017.222330538772;5504.311961004874;5743.167240750068;5771.826845194651;5791.247137872049;5791.82624521265;4137.420761093449;4158.958410415918;4173.227952828736;4179.644730197937;4187.644050255732;5770.182392546334;6028.879422411571;6096.085587161917;6116.143739876421;6172.722227499773;4201.6554702494905;4202.054537728986;4205.789710514462;4222.113356195172;4241.321388577812;4284.507281662586;4290.935635965463;4299.140171965557;4323.135372925428;4326.2212801696;4912.582430493448;4940.1601727706375;4950.529699678525;4954.355933728664;4969.35398398206;5575.665460072328;5864.739081097585;5873.882522349614;5885.61743486672;5892.941070589325;1464.9452394276318;1494.2902121492205;1495.9326830292664;1505.4881340344336;1517.4157949189641;919.0212423768666;944.891337496183;951.7810903492235;964.1419136968104;972.3145182646359;5124.154514505065;5621.718914054362;5800.767969281266;5815.302163740378;5828.708564571754;5944.108383742387;6088;6105.572609917263;6143.631382116998;6154.569180157436;5562.082256427725;5739.426057394311;5821;5854.941450585525;5862.384449632812;3168.651448340681;3177.698118678722;3232.175795172216;3243.4810430331504;3259.869605215812;6366.6180029198395;6367.681615919186;6381.2031841054495;6381.968090159612;6404.519661025442;5908.940910590839;6101.816945491642;6156.230471191101;6221.440070393686;6230.190075290183;6203.7828675996125;6215.471684906744;6259.873222819845;6305.873882522324;6332.511859712964;5930.733117009831;5979.880402391841;6038.63768173911;6073;6089.969550152221;5992.0712289595185;5993.490553303018;5995.370486099071;6012.368701286302;6043.8186854394435;6091.9086213707715;6242.3133455320785;6339.017452294902;6358.427741503287;6370.872582548231;4294.957050429456;4311.3964045034345;4322.502912165141;4327.826886924488;4338.761368124658;6149.538784591263;6150.7847225346895;6165.630062196283;6173.228346456693;6195.349488303844;5790.739416726342;5910.822675319747;5929.940700593112;5935.762569497172;5997.280326360865;5860.970695146497;5873.4126587340925;5878.911816322673;5887.646741195542;5897.174395584536;5272.499112584298;5845.941540584709;5853.882922341614;5855.03856208158;5877.265341832271;5864.882702346014;5869.7945571904775;5887.852803679943;5924.289085309791;5926.288845338587;5774.942250577608;5832.212651292021;5856.3558008618165;5861.882762344814;5915.940840591711 11:40:00 INFO - PROCESS | 23421 | |5;yui.html;712.277038805612;718.7412531488665;762.2796457347802;774.4733581164808;816.4203415574941;13571;13876.306184690762;14774.704505909875;14877.18175500347;14907.701845963087;14000.859991400082;14077.50728724495;14078.507252246174;14090.36593353299;14131;807.4025221336213;807.6325272001254;811.5130921447144;813.6663967773214;839.4333824668355;825.2160447574798;827.9586020698971;828.9461185022984;830.6262182018116;831.4387788242942;863.6804382378498;869.995650021749;874.2175752701329;874.2656168818191;876.3120950054209;863.7279257034014;867.1631875240361;868.4008034456268;868.7393781865416;870.2428886868433;627.4572494792018;628.2555172121051;628.3245511075612;629.6662768732579;630.2279707358495;14345.569632911029;14534.05528640635;14543.636409089751;14556.927215363961;14589.927050364786;14042.297885105805;14166.858331416657;14388.136711797326;14542.636434089232;14552.563423097325;11803.645890623295;12038.277703337828;12089.93955030228;12119.697007574881;12297.077719171099;3720.8837348795255;3750.3999360102252;3916.8824935251705;3968.0476685595536;3969.8412063517426;73022;74679.62660186719;74741;75065;75082.62458687671;10747.946260268649;10749.570017199381;11055.944720276348;11073.224874258725;11149.777004459866;18011.459656210074;18078.09609519545;18132.365367212085;18152.63694726098;18233.635327293647;8104.675812967415;8215.876761848576;8239.299659529008;8539.914600853912;8703.695370661997;4482.820687172477;4506.684532082722;4512.309006735672;4582.633389328846;4633.142868569325;3468.9132771680406;3590.605033446371;3594.8202589870402;3602.495650608917;3613.512175856278;593.1666009257001;597.725046478616;598.1536126381209;605.0651743056987;614.4961131871911;715.6815217228387;732.0995175933632;736.3777607921298;739.3161325773638;745.5563939456015;9276.953615231881;9300.39547429415;9444.480553569481;9544.475053872104;9660.17888479473;573.7819628541212;641.9358064193636;718.547315191426;720.8197950512372;722.3318430451811;4207.957920420818;4279.144171165779;4333.198358303724;4360.520342762294;4399.956000440018;105043;106838.46580767202;107733;119051.09489051199;119179.40410298067;58457.70771146117;92627.51607387418;98281.50859245658;101040;101679.491602543;53700.73149634227;55999.440005600234;60830;88696.556517217;89772.10227897768;8163;8232.17678232172;8285.792855178668;8711.738647840575;8891.510966896883;51203.743981279855;52226.477735222164;52387.21419178639;52496.21255681244;53172.20241696455;65687.34312656813;73119.26880731338;73270;73510.26489735034;73890.26109738834;10237.641682541076;10361.326513776581;10402.427866467417;10556.472176390997;10934.070603998749;12289.324087174933;12574.182678126259;12668.936655316664;12670.556530521388;12675.429605667583;10148.289619726844;10483.528241229316;10887.292325998786;10940.656815750888;11096.722581935515;11674.649760507198;11842.82235766447;11844.763104737685;11880.579250148643;12545.749085018431;11775;11822.586209482626;11958.103142264192;12113.091518136;12631.11582189238;9834;10055;10204.540795664065;10268.229882758973;10314.071733544017;9569.521523923915;9845.163161131384;9849.704508864745;9919.801603967735;9943.850842237516 11:40:00 INFO - PROCESS | 23421 | __end_tp_report 11:40:00 INFO - PROCESS | 23421 | __start_cc_report 11:40:00 INFO - PROCESS | 23421 | _x_x_mozilla_cycle_collect,363 11:40:00 INFO - PROCESS | 23421 | __end_cc_report 11:40:00 INFO - PROCESS | 23421 | __startTimestamp1464892800388__endTimestamp 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | ------- Summary: start ------- 11:40:00 INFO - PROCESS | 23421 | Number of tests: 6 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | [#0] dojo.html Cycles:165 Average:5483.32 Median:5719.49 stddev:730.89 (12.8%) stddev-sans-first:708.72 11:40:00 INFO - PROCESS | 23421 | Values: 3095.3 3144.4 3176.7 3186.4 3187.2 5383.9 5437.1 5464.0 5494.9 5551.8 5380.8 5439.7 5486.5 5503.0 5611.3 4929.1 4965.8 5062.4 5113.1 5179.8 810.7 4962.8 5111.4 5156.4 5195.6 5046.9 5074.6 5096.0 5097.4 5131.1 4980.9 5084.0 5084.3 5099.3 5112.0 5000.2 5088.3 5091.3 5096.3 5141.3 5496.3 5535.4 5551.4 5552.5 5552.8 5709.5 5768.4 5773.9 5983.6 5987.2 5860.5 5870.7 5882.4 5897.3 5949.6 5472.4 5499.9 5519.1 5519.9 5520.6 5760.5 5822.8 5828.2 5908.9 6008.1 5678.1 5736.1 5847.5 5869.1 5895.0 5923.6 5955.3 5964.1 5967.9 5986.4 5704.5 5954.7 5955.8 5957.6 5968.0 5937.5 6016.7 6041.7 6045.8 6097.1 4507.4 4509.6 4515.5 4524.5 4562.3 3912.4 3980.2 4008.0 4051.4 4080.2 5693.4 5712.9 5725.9 5740.3 5781.3 5921.8 5956.4 6010.5 6013.0 6013.2 5569.0 5599.4 5638.3 5707.1 5719.6 5105.4 5136.4 5139.6 5145.4 5186.3 6200.0 6206.9 6208.8 6212.8 6224.8 5648.8 5947.2 5980.3 5980.7 5995.5 6147.9 6194.1 6231.3 6237.9 6275.9 5911.5 5912.7 5925.6 5940.8 5960.1 5734.9 5817.2 5968.6 5971.0 5996.8 5698.0 5705.9 5718.0 5721.9 5722.8 5695.7 5715.5 5719.5 5725.8 5761.7 5521.8 5717.9 5734.3 5770.0 5779.0 5868.5 5891.2 5913.7 5934.9 5938.9 5434.1 5761.2 5763.8 5765.7 5780.5 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | [#1] ext.html Cycles:180 Average:60805.50 Median:43030.96 stddev:118990.54 (276.5%) stddev-sans-first:119238.39 11:40:00 INFO - PROCESS | 23421 | Values: 566.7 614.8 631.7 636.5 637.7 32816.8 35619.3 43292.0 44359.3 44459.8 45418.5 46143.0 46299.5 46346.3 46654.8 8767.5 8858.3 8919.6 8936.6 8946.6 8740.9 8889.7 8919.7 8926.9 8948.1 8903.6 8973.3 9013.7 9027.6 9027.6 8919.6 8935.9 8956.3 8967.8 8993.5 8799.3 8934.6 8936.8 8954.9 8995.4 42021.4 42760.0 43079.0 43103.4 43146.6 3297.2 3341.4 3442.0 3452.4 3531.0 29974.0 32737.8 32800.0 32930.0 33046.0 4338.3 4497.3 4520.0 4565.2 4589.8 339265.0 339510.0 340942.0 341466.0 341537.0 60879.0 61279.8 61392.0 61524.7 61781.0 63761.4 64797.0 64825.0 64841.0 65017.3 14889.9 15151.0 15293.8 15500.1 15646.3 11525.4 11576.0 11606.5 11629.5 11679.8 20108.2 20168.4 20356.4 20390.3 20477.7 7190.5 7460.9 7506.1 7567.9 7611.9 916.9 1045.1 1046.7 1156.4 1238.7 32803.7 33147.7 33377.3 33385.8 33897.8 1101.6 1144.9 1210.6 1213.3 1221.0 16620.4 17055.7 17070.2 17199.8 17259.2 525027.0 528702.0 529001.0 535987.0 536098.0 58262.0 59158.0 59253.7 59363.0 59407.4 1354.8 1396.3 1410.9 1414.4 1416.6 30501.5 31673.0 31694.7 31891.8 32251.4 49981.0 50449.5 50493.5 50523.7 50559.5 445164.0 455716.0 456923.0 457221.0 458789.0 28294.3 28994.3 29064.4 29076.0 29085.9 48354.0 49327.8 49401.7 49662.5 50513.0 40256.8 42096.4 42696.0 42970.4 43063.6 42061.0 42142.8 42146.6 42507.8 42700.8 42227.8 42345.6 42682.6 42998.4 43167.1 35154.6 38130.4 38436.6 38469.6 38714.8 28579.0 28830.1 28991.7 29257.4 29372.1 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | [#2] jquery.html Cycles:180 Average:27753.66 Median:22239.44 stddev:77329.14 (347.7%) stddev-sans-first:77518.80 11:40:00 INFO - PROCESS | 23421 | Values: 402.9 405.4 406.9 411.8 415.7 18126.3 19046.3 19716.9 20167.6 20214.1 18266.4 18476.8 18904.0 19156.5 19226.9 5479.5 5514.6 5716.7 5723.8 5733.2 5588.6 5610.8 5617.3 5627.9 5634.1 5537.0 5540.1 5611.1 5637.5 5680.4 5588.6 5611.4 5620.1 5635.3 5656.2 4960.3 5079.0 5094.7 5105.1 5135.6 21438.2 22226.4 22252.4 22951.5 22977.2 2271.3 2275.9 2292.7 2364.2 2411.3 14138.9 14367.6 14440.6 14530.9 14541.6 1931.3 1935.9 2015.5 2047.4 2054.8 75094.6 77495.0 77592.0 77978.2 78799.0 10523.6 10652.7 10938.6 11069.6 11098.0 15037.4 15198.8 15229.5 15244.1 15277.8 7767.2 8052.4 8128.3 8137.5 8227.4 7703.7 7741.2 7758.1 7799.0 7877.7 6630.9 6671.4 6724.9 6729.9 6772.0 1862.8 1926.6 1928.4 1961.6 1967.5 917.8 1004.1 1017.5 1045.1 1123.4 19020.6 19611.1 19618.2 19830.8 19933.9 1031.5 1032.3 1036.5 1082.4 1130.8 10664.9 11279.5 11282.7 11290.4 11351.5 453580.0 455529.0 457090.0 490318.0 497939.0 49058.5 76595.6 79973.6 82224.6 84478.2 1034.2 1035.4 1043.7 1054.2 1065.2 16883.2 16980.7 17390.4 17573.9 17787.6 30757.0 37985.8 39247.4 39759.6 40758.2 51007.0 52299.5 52805.5 52855.7 52953.7 7580.8 7878.6 8095.9 8474.9 9073.5 10072.0 13501.7 13511.3 13863.7 13931.5 11865.3 11965.6 12007.8 12063.8 12088.8 11687.2 11695.5 11877.8 11881.2 12222.9 11764.8 11768.3 12104.6 12195.8 12470.3 8006.6 8026.9 8043.8 8076.7 8140.9 11494.3 12099.9 12119.2 12227.6 12262.9 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | [#3] mootools.html Cycles:180 Average:5821.30 Median:4712.48 stddev:3378.10 (71.7%) stddev-sans-first:3372.00 11:40:00 INFO - PROCESS | 23421 | Values: 1503.1 1525.6 1693.6 1799.8 1829.5 7976.9 8328.5 8608.5 9200.2 9201.5 8621.9 8667.1 8700.7 8726.3 8763.3 2232.3 2252.5 2265.1 2265.5 2272.2 2213.6 2223.7 2265.6 2265.9 2266.0 2245.2 2247.8 2251.1 2256.3 2263.8 2208.6 2209.2 2230.7 2236.3 2237.2 2094.1 2104.5 2107.3 2109.1 2111.2 8573.7 8633.7 8656.2 8658.1 8679.4 5290.6 5417.8 5424.4 5437.0 5452.5 3190.6 3276.9 3394.1 3396.7 3418.1 1112.4 1140.6 1161.9 1162.7 1171.5 12882.2 12914.9 12939.0 12940.7 12956.4 4710.3 4714.7 4816.9 4828.3 4926.2 10539.0 10560.2 10579.5 10583.9 10587.3 5349.9 5427.3 5439.6 5452.3 5464.3 4354.6 4689.6 4830.5 4993.8 5007.9 4111.6 4144.7 4199.1 4212.2 4271.1 1312.7 1333.2 1337.4 1338.6 1342.5 816.9 820.0 918.9 933.5 938.5 5826.1 5838.6 5882.1 6046.6 6059.5 447.6 452.3 453.0 951.7 1037.7 3775.2 3839.2 3846.6 3867.5 3880.5 10950.5 11153.0 11165.9 11250.4 11262.6 10812.4 11163.1 11174.3 11183.7 11226.8 8308.5 8312.7 8334.5 8419.3 8436.0 5748.9 5764.3 5870.3 5898.6 5934.7 10057.1 10260.7 10281.1 10304.8 10406.8 9698.6 10112.1 10182.8 10259.9 10322.5 7778.0 7850.1 7956.8 7970.4 7978.6 8292.3 8356.5 8375.7 8390.5 8396.8 7482.5 7618.1 7703.6 7786.6 7839.2 7384.9 7451.2 7474.7 7549.5 7553.4 6923.9 6954.7 6974.7 6997.1 7007.8 4957.0 5053.4 5072.3 5173.6 5179.9 5171.0 5172.9 5212.8 5285.3 5297.5 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | [#4] prototype.html Cycles:180 Average:4953.72 Median:5683.62 stddev:1472.50 (25.9%) stddev-sans-first:1435.25 11:40:00 INFO - PROCESS | 23421 | Values: 335.4 342.3 344.7 348.6 354.8 5531.9 5537.8 5581.5 5610.4 5627.8 5523.6 5529.6 5532.8 5560.9 5620.6 4138.6 4362.6 4371.7 4405.2 4432.2 4218.9 4369.9 4377.3 4406.0 4412.5 4323.9 4329.8 4337.4 4340.0 4390.3 4306.1 4372.6 4383.8 4389.2 4404.0 3867.4 3867.7 3869.4 3877.6 3886.2 5302.8 5363.9 5369.3 5371.9 5391.2 4972.3 5007.1 5014.8 5016.4 5017.2 5504.3 5743.2 5771.8 5791.2 5791.8 4137.4 4159.0 4173.2 4179.6 4187.6 5770.2 6028.9 6096.1 6116.1 6172.7 4201.7 4202.1 4205.8 4222.1 4241.3 4284.5 4290.9 4299.1 4323.1 4326.2 4912.6 4940.2 4950.5 4954.4 4969.4 5575.7 5864.7 5873.9 5885.6 5892.9 1464.9 1494.3 1495.9 1505.5 1517.4 919.0 944.9 951.8 964.1 972.3 5124.2 5621.7 5800.8 5815.3 5828.7 5944.1 6088.0 6105.6 6143.6 6154.6 5562.1 5739.4 5821.0 5854.9 5862.4 3168.7 3177.7 3232.2 3243.5 3259.9 6366.6 6367.7 6381.2 6382.0 6404.5 5908.9 6101.8 6156.2 6221.4 6230.2 6203.8 6215.5 6259.9 6305.9 6332.5 5930.7 5979.9 6038.6 6073.0 6090.0 5992.1 5993.5 5995.4 6012.4 6043.8 6091.9 6242.3 6339.0 6358.4 6370.9 4295.0 4311.4 4322.5 4327.8 4338.8 6149.5 6150.8 6165.6 6173.2 6195.3 5790.7 5910.8 5929.9 5935.8 5997.3 5861.0 5873.4 5878.9 5887.6 5897.2 5272.5 5845.9 5853.9 5855.0 5877.3 5864.9 5869.8 5887.9 5924.3 5926.3 5774.9 5832.2 5856.4 5861.9 5915.9 11:40:00 INFO - PROCESS | 23421 | 11:40:00 INFO - PROCESS | 23421 | [#5] yui.html Cycles:180 Average:19335.53 Median:27918.44 stddev:28291.90 (101.3%) stddev-sans-first:28336.71 11:40:00 INFO - PROCESS | 23421 | Values: 712.3 718.7 762.3 774.5 816.4 13571.0 13876.3 14774.7 14877.2 14907.7 14000.9 14077.5 14078.5 14090.4 14131.0 807.4 807.6 811.5 813.7 839.4 825.2 828.0 828.9 830.6 831.4 863.7 870.0 874.2 874.3 876.3 863.7 867.2 868.4 868.7 870.2 627.5 628.3 628.3 629.7 630.2 14345.6 14534.1 14543.6 14556.9 14589.9 14042.3 14166.9 14388.1 14542.6 14552.6 11803.6 12038.3 12089.9 12119.7 12297.1 3720.9 3750.4 3916.9 3968.0 3969.8 73022.0 74679.6 74741.0 75065.0 75082.6 10747.9 10749.6 11055.9 11073.2 11149.8 18011.5 18078.1 18132.4 18152.6 18233.6 8104.7 8215.9 8239.3 8539.9 8703.7 4482.8 4506.7 4512.3 4582.6 4633.1 3468.9 3590.6 3594.8 3602.5 3613.5 593.2 597.7 598.2 605.1 614.5 715.7 732.1 736.4 739.3 745.6 9277.0 9300.4 9444.5 9544.5 9660.2 573.8 641.9 718.5 720.8 722.3 4208.0 4279.1 4333.2 4360.5 4400.0 105043.0 106838.5 107733.0 119051.1 119179.4 58457.7 92627.5 98281.5 101040.0 101679.5 53700.7 55999.4 60830.0 88696.6 89772.1 8163.0 8232.2 8285.8 8711.7 8891.5 51203.7 52226.5 52387.2 52496.2 53172.2 65687.3 73119.3 73270.0 73510.3 73890.3 10237.6 10361.3 10402.4 10556.5 10934.1 12289.3 12574.2 12668.9 12670.6 12675.4 10148.3 10483.5 10887.3 10940.7 11096.7 11674.6 11842.8 11844.8 11880.6 12545.7 11775.0 11822.6 11958.1 12113.1 12631.1 9834.0 10055.0 10204.5 10268.2 10314.1 9569.5 9845.2 9849.7 9919.8 9943.9 11:40:00 INFO - PROCESS | 23421 | -------- Summary: end -------- 11:40:00 INFO - PROCESS | 23421 | 11:40:01 INFO - TEST-INFO | 23421: exit 0 11:40:01 INFO - TEST-OK | dromaeo_css | took 1110697ms 11:40:01 INFO - TEST-START | kraken 11:40:01 INFO - operating with platform_type : linux_ 11:40:01 INFO - Initialising browser for kraken test... 11:40:01 INFO - TEST-INFO | started process 23657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDPmX5v/profile http://localhost:59845/getInfo.html) 11:40:05 INFO - PROCESS | 23657 | __metrics Screen width/height:1600/1200 11:40:05 INFO - PROCESS | 23657 | colorDepth:24 11:40:05 INFO - PROCESS | 23657 | Browser inner width/height: 1024/697 11:40:05 INFO - PROCESS | 23657 | __metrics 11:40:06 ERROR - PROCESS | 23657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:40:07 INFO - TEST-INFO | 23657: exit 0 11:40:07 INFO - Browser initialized. 11:40:07 INFO - Running cycle 1/1 for kraken test... 11:40:07 INFO - TEST-INFO | started process 23778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDPmX5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:19 INFO - PROCESS | 23778 | RSS: Main: 167485440 11:40:19 INFO - PROCESS | 23778 | 11:40:21 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59845/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:22 INFO - PROCESS | 23778 | RSS: Main: 172879872 11:40:22 INFO - PROCESS | 23778 | 11:40:25 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59845/tests/kraken/driver.html?testName=audio-dft) 11:40:25 INFO - PROCESS | 23778 | RSS: Main: 171622400 11:40:25 INFO - PROCESS | 23778 | 11:40:28 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59845/tests/kraken/driver.html?testName=audio-fft) 11:40:29 INFO - PROCESS | 23778 | RSS: Main: 166629376 11:40:29 INFO - PROCESS | 23778 | 11:40:31 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59845/tests/kraken/driver.html?testName=audio-oscillator) 11:40:32 INFO - PROCESS | 23778 | RSS: Main: 167186432 11:40:32 INFO - PROCESS | 23778 | 11:40:34 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:35 INFO - PROCESS | 23778 | RSS: Main: 168030208 11:40:35 INFO - PROCESS | 23778 | 11:40:38 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59845/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:38 INFO - PROCESS | 23778 | RSS: Main: 168734720 11:40:38 INFO - PROCESS | 23778 | 11:40:42 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59845/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:42 INFO - PROCESS | 23778 | RSS: Main: 169140224 11:40:42 INFO - PROCESS | 23778 | 11:40:45 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59845/tests/kraken/driver.html?testName=json-parse-financial) 11:40:46 INFO - PROCESS | 23778 | RSS: Main: 168333312 11:40:46 INFO - PROCESS | 23778 | 11:40:48 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:48 INFO - PROCESS | 23778 | RSS: Main: 168759296 11:40:48 INFO - PROCESS | 23778 | 11:40:50 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:51 INFO - PROCESS | 23778 | RSS: Main: 168734720 11:40:51 INFO - PROCESS | 23778 | 11:40:53 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:53 INFO - PROCESS | 23778 | RSS: Main: 169234432 11:40:53 INFO - PROCESS | 23778 | 11:40:56 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:57 INFO - PROCESS | 23778 | RSS: Main: 169058304 11:40:57 INFO - PROCESS | 23778 | 11:40:59 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:00 INFO - PROCESS | 23778 | RSS: Main: 168615936 11:41:00 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | Cycle 1(1): loaded http://localhost:59845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59845/tests/kraken/driver.html?testName=ai-astar) 11:41:02 INFO - PROCESS | 23778 | RSS: Main: 169594880 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | __start_tp_report 11:41:02 INFO - PROCESS | 23778 | _x_x_mozilla_page_load 11:41:02 INFO - PROCESS | 23778 | _x_x_mozilla_page_load_details 11:41:02 INFO - PROCESS | 23778 | |i|pagename|runs| 11:41:02 INFO - PROCESS | 23778 | |0;ai-astar;113;106;112;113;113;113;112;112;112;111 11:41:02 INFO - PROCESS | 23778 | |1;audio-beat-detection;159;124;161;176;136;161;150;135;188;125 11:41:02 INFO - PROCESS | 23778 | |2;audio-dft;162;161;161;162;161;164;174;163;162;160 11:41:02 INFO - PROCESS | 23778 | |3;audio-fft;74;75;75;157;77;75;75;75;165;77 11:41:02 INFO - PROCESS | 23778 | |4;audio-oscillator;84;84;147;84;84;84;150;84;84;146 11:41:02 INFO - PROCESS | 23778 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;118;117;117 11:41:02 INFO - PROCESS | 23778 | |6;imaging-darkroom;148;148;148;150;147;146;147;148;147;146 11:41:02 INFO - PROCESS | 23778 | |7;imaging-desaturate;96;96;100;95;95;96;96;100;96;96 11:41:02 INFO - PROCESS | 23778 | |8;json-parse-financial;55;56;54;52;56;53;53;53;52;53 11:41:02 INFO - PROCESS | 23778 | |9;json-stringify-tinderbox;62;63;62;62;63;63;62;63;63;64 11:41:02 INFO - PROCESS | 23778 | |10;stanford-crypto-aes;79;85;79;80;81;86;82;80;109;83 11:41:02 INFO - PROCESS | 23778 | |11;stanford-crypto-ccm;123;128;124;128;132;122;130;121;145;124 11:41:02 INFO - PROCESS | 23778 | |12;stanford-crypto-pbkdf2;168;168;168;158;165;160;159;160;157;157 11:41:02 INFO - PROCESS | 23778 | |13;stanford-crypto-sha256-iterative;62;63;64;63;71;64;62;62;69;61 11:41:02 INFO - PROCESS | 23778 | __end_tp_report 11:41:02 INFO - PROCESS | 23778 | __start_cc_report 11:41:02 INFO - PROCESS | 23778 | _x_x_mozilla_cycle_collect,875 11:41:02 INFO - PROCESS | 23778 | __end_cc_report 11:41:02 INFO - PROCESS | 23778 | __startTimestamp1464892862361__endTimestamp 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | ------- Summary: start ------- 11:41:02 INFO - PROCESS | 23778 | Number of tests: 14 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.11 (1.9%) stddev-sans-first:2.19 11:41:02 INFO - PROCESS | 23778 | Values: 113.0 106.0 112.0 113.0 113.0 113.0 112.0 112.0 112.0 111.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:160.00 stddev:21.45 (13.4%) stddev-sans-first:22.58 11:41:02 INFO - PROCESS | 23778 | Values: 159.0 124.0 161.0 176.0 136.0 161.0 150.0 135.0 188.0 125.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:4.03 (2.5%) stddev-sans-first:4.26 11:41:02 INFO - PROCESS | 23778 | Values: 162.0 161.0 161.0 162.0 161.0 164.0 174.0 163.0 162.0 160.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:36.16 (48.2%) stddev-sans-first:37.73 11:41:02 INFO - PROCESS | 23778 | Values: 74.0 75.0 75.0 157.0 77.0 75.0 75.0 75.0 165.0 77.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:84.00 stddev:30.77 (36.6%) stddev-sans-first:31.85 11:41:02 INFO - PROCESS | 23778 | Values: 84.0 84.0 147.0 84.0 84.0 84.0 150.0 84.0 84.0 146.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:41:02 INFO - PROCESS | 23778 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.18 (0.8%) stddev-sans-first:1.24 11:41:02 INFO - PROCESS | 23778 | Values: 148.0 148.0 148.0 150.0 147.0 146.0 147.0 148.0 147.0 146.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.84 (1.9%) stddev-sans-first:1.94 11:41:02 INFO - PROCESS | 23778 | Values: 96.0 96.0 100.0 95.0 95.0 96.0 96.0 100.0 96.0 96.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:1.49 (2.8%) stddev-sans-first:1.51 11:41:02 INFO - PROCESS | 23778 | Values: 55.0 56.0 54.0 52.0 56.0 53.0 53.0 53.0 52.0 53.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 11:41:02 INFO - PROCESS | 23778 | Values: 62.0 63.0 62.0 62.0 63.0 63.0 62.0 63.0 63.0 64.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.50 stddev:8.97 (11.0%) stddev-sans-first:9.30 11:41:02 INFO - PROCESS | 23778 | Values: 79.0 85.0 79.0 80.0 81.0 86.0 82.0 80.0 109.0 83.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.00 stddev:7.07 (5.5%) stddev-sans-first:7.29 11:41:02 INFO - PROCESS | 23778 | Values: 123.0 128.0 124.0 128.0 132.0 122.0 130.0 121.0 145.0 124.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:4.71 (2.9%) stddev-sans-first:4.47 11:41:02 INFO - PROCESS | 23778 | Values: 168.0 168.0 168.0 158.0 165.0 160.0 159.0 160.0 157.0 157.0 11:41:02 INFO - PROCESS | 23778 | 11:41:02 INFO - PROCESS | 23778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:63.50 stddev:3.28 (5.2%) stddev-sans-first:3.39 11:41:02 INFO - PROCESS | 23778 | Values: 62.0 63.0 64.0 63.0 71.0 64.0 62.0 62.0 69.0 61.0 11:41:02 INFO - PROCESS | 23778 | -------- Summary: end -------- 11:41:02 INFO - PROCESS | 23778 | 11:41:03 INFO - TEST-INFO | 23778: exit 0 11:41:03 INFO - TEST-OK | kraken | took 62227ms 11:41:03 INFO - SUITE-END | took 1172s 11:41:03 INFO - Completed test suite (00:19:33) 11:41:03 INFO - javascript benchmark 11:41:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7295.147217544415, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.349976504934, 3144.402563512931, 3176.6823317668236, 3186.426443240216, 3187.171335452783, 5383.9461605383985, 5437.102878025126, 5463.972680136599, 5494.890102197954, 5551.833444996647, 5380.784768609251, 5439.673619582828, 5486.451354864522, 5502.972485137579, 5611.270534830476, 4929.112759703261, 4965.801367945278, 5062.417821950467, 5113.1052065888325, 5179.766910489037, 810.7019513407438, 4962.751862406883, 5111.412187598418, 5156.355455568054, 5195.558377537914, 5046.949530504721, 5074.644774865761, 5096.006278775641, 5097.388313402397, 5131.1277082895995, 4980.850574482772, 5084.0, 5084.339035925343, 5099.311592934943, 5111.974440127776, 5000.224965130411, 5088.2622019807295, 5091.312672789163, 5096.337476128117, 5141.30592370029, 5496.285482887239, 5535.418781028015, 5551.3893471718075, 5552.5280351170195, 5552.750126244328, 5709.543236541067, 5768.42315768424, 5773.8556536086935, 5983.640981541122, 5987.191729116601, 5860.472557469806, 5870.706464676792, 5882.3823498532465, 5897.292324921037, 5949.613275137102, 5472.425395333473, 5499.890002199933, 5519.089350257243, 5519.917201241944, 5520.613557051008, 5760.452756988079, 5822.767089316465, 5828.242328497353, 5908.940910590839, 6008.068749343859, 5678.063119585305, 5736.110902809987, 5847.473727364558, 5869.119632055226, 5895.0, 5923.644581325048, 5955.285365756137, 5964.075568286922, 5967.880642387128, 5986.431289027535, 5704.458076482728, 5954.672493012839, 5955.79154729591, 5957.582969192202, 5968.0, 5937.465628093492, 6016.729247183887, 6041.667708275999, 6045.818625441244, 6097.085437184458, 4507.391502147234, 4509.571590698878, 4515.458145022552, 4524.457065152203, 4562.315652652062, 3912.374020156761, 3980.164165525272, 4007.979960100181, 4051.4125451809323, 4080.2043601498017, 5693.373728889819, 5712.914306285409, 5725.912076705413, 5740.339860916049, 5781.277340332458, 5921.822345329647, 5956.434138756811, 6010.489108425745, 6012.969935150296, 6013.248343957005, 5568.972155139199, 5599.356074051455, 5638.2670252866865, 5707.143928410772, 5719.571032172604, 5105.361829771278, 5136.383633963948, 5139.614528910347, 5145.382554093533, 5186.299849520342, 6200.0, 6206.937930620727, 6208.782692605737, 6212.782552610637, 6224.813255602339, 5648.8305350840365, 5947.197128387612, 5980.282366116094, 5980.671063091398, 5995.490383317379, 6147.938520614736, 6194.090133934475, 6231.314555398993, 6237.906431403442, 6275.874482510416, 5911.497522710618, 5912.73392697321, 5925.555583331354, 5940.79207227745, 5960.0761881908375, 5734.913976290442, 5817.185594016756, 5968.612040217372, 5970.9701451492465, 5996.790112346047, 5697.971510142423, 5705.942940570541, 5717.971410142923, 5721.914171287351, 5722.799702010409, 5695.686737229492, 5715.542756579547, 5719.48524632785, 5725.828225153252, 5761.654300741969, 5521.834344969658, 5717.885642287214, 5734.34055083654, 5770.0, 5779.0, 5868.530517558671, 5891.204687367322, 5913.70431478433, 5934.9109763354445, 5938.940610593839, 5434.076207044733, 5761.164631128547, 5763.7982670606325, 5765.711714414347, 5780.537556995514], "value": 5435.387019762744, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7024811973713, 614.7571709174877, 631.6967855429391, 636.5003472274266, 637.6907200007995, 32816.83591582042, 35619.28761424773, 43291.99999999996, 44359.33460998088, 44459.77770111153, 45418.545814541845, 46143.0, 46299.53700462994, 46346.30480542786, 46654.76672616632, 8767.47395156291, 8858.29133669305, 8919.554022298858, 8936.597853096593, 8946.568549032156, 8740.8688869667, 8889.68886088987, 8919.687810926618, 8926.86609700855, 8948.06045365237, 8903.55482225886, 8973.28213742899, 9013.729588112366, 9027.638894444215, 9027.638894444248, 8919.598618062171, 8935.927688677335, 8956.283497320199, 8967.775805604846, 8993.460392376413, 8799.252063574604, 8934.597943092576, 8936.821263574757, 8954.86567701485, 8995.415298005608, 42021.36967945483, 42760.0, 43079.0, 43103.35344969828, 43146.56853431457, 3297.2086699192023, 3341.3818443588016, 3442.0, 3452.4130897747445, 3530.9646903530893, 29974.0, 32737.836310818533, 32800.0, 32930.0, 33046.0, 4338.305871060616, 4497.325401189815, 4519.977400113011, 4565.223911934946, 4589.839355622571, 339265.0, 339510.0, 340941.9999999975, 341466.0, 341537.0, 60879.0, 61279.77440451255, 61392.0, 61524.69237653783, 61781.0, 63761.36238637554, 64797.0, 64825.0, 64841.0, 65017.34982650113, 14889.851101489063, 15151.0, 15293.847061529465, 15500.147491888054, 15646.295916683777, 11525.366104864146, 11576.0, 11606.477708503138, 11629.47667354971, 11679.766404671858, 20108.195672172948, 20168.394948151577, 20356.389308320773, 20390.28633997803, 20477.692834607493, 7190.460715446363, 7460.85078298431, 7506.099268087864, 7567.886481702779, 7611.923880761122, 916.9403988740711, 1045.0959919669583, 1046.706922061824, 1156.4275683536703, 1238.7398646284382, 32803.67196328006, 33147.66852331494, 33377.3324533508, 33385.83307083449, 33897.830510847285, 1101.5979167603766, 1144.9370284634258, 1210.5944508589546, 1213.3266037349356, 1221.0414824362833, 16620.418285359956, 17055.744163837553, 17070.23183956725, 17199.828001719823, 17259.22333494996, 525027.0, 528702.0, 529001.0, 535987.0, 536098.0, 58262.0, 59158.0, 59253.703731481066, 59363.0, 59407.40592594105, 1354.7764618837978, 1396.3297617143828, 1410.9082909610843, 1414.3918115210352, 1416.5608661315025, 30501.54247686242, 31673.0, 31694.683053169174, 31891.840540798075, 32251.354972899942, 49981.0, 50449.49550504448, 50493.49506504888, 50523.74738126286, 50559.49440505548, 445164.0, 455716.0, 456923.0, 457221.0, 458789.0, 28294.292642683275, 28994.275143120747, 29064.418711626073, 29076.0, 29085.85457072701, 48354.0, 49327.753361232964, 49401.737420094665, 49662.50337496724, 50513.0, 40256.79871600623, 42096.3685544711, 42696.0, 42970.35544466898, 43063.56936430721, 42061.0, 42142.789286053376, 42146.57853421549, 42507.7874610625, 42700.78649606732, 42227.788861055495, 42345.576544234165, 42682.5731742691, 42998.35502467528, 43167.13665726605, 35154.64845351514, 38130.42804357992, 38436.61563384331, 38469.61530384772, 38714.80642596769, 28579.0, 28830.135095947157, 28991.710082898902, 29257.414851702422, 29372.11883643494], "value": 20391.557293489423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.9456023436837, 405.36155555000846, 406.9165821006694, 411.7570633326337, 415.74016239850096, 18126.27494900204, 19046.333378331725, 19716.901415492903, 20167.59664806703, 20214.09036593353, 18266.360677376295, 18476.81523184768, 18904.0, 19156.521086972833, 19226.903865480654, 5479.479449452296, 5514.641548299368, 5716.685582292972, 5723.828285151431, 5733.168690539869, 5588.608797384185, 5610.803621873235, 5617.297837770278, 5627.859303517424, 5634.126710359901, 5537.0, 5540.113581826909, 5611.102223644218, 5637.548996080303, 5680.403557626451, 5588.636738611997, 5611.438856114397, 5620.072688006474, 5635.3237611486475, 5656.179853921179, 4960.280759289883, 5079.0, 5094.694318340911, 5105.106606343912, 5135.64050516464, 21438.249661261936, 22226.44433889166, 22252.443688907908, 22951.54096918069, 22977.195798147153, 2271.3299576624936, 2275.8520696154696, 2292.6904867842795, 2364.2220391040632, 2411.2645643078854, 14138.858611413858, 14367.568972930725, 14440.638984025378, 14530.92734536331, 14541.636459088502, 1931.3240365871973, 1935.8935258560773, 2015.5465020370445, 2047.4471892589067, 2054.8356131509595, 75094.62452687701, 77495.0, 77591.99999999943, 77978.22021779823, 78799.0, 10523.579056837641, 10652.680419587425, 10938.617148399768, 11069.612563560237, 11098.0, 15037.398504059935, 15198.772018419733, 15229.543113706606, 15244.085354878744, 15277.847221527865, 7767.18444563324, 8052.355811535063, 8128.349732021424, 8137.471064380797, 8227.382946279053, 7703.6918523259565, 7741.225877412214, 7758.138046868824, 7798.961005194938, 7877.724279650185, 6630.867382652416, 6671.366220209073, 6724.9327506725285, 6729.937878265378, 6771.966140169267, 1862.7764668239897, 1926.589935813602, 1928.4021953194554, 1961.5586493039236, 1967.4589487890944, 917.8210249001514, 1004.1314263162312, 1017.4709151241461, 1045.095991966943, 1123.3767206386856, 19020.61958760817, 19611.117499712545, 19618.215271388985, 19830.801691983183, 19933.900330498254, 1031.51003273446, 1032.339302846179, 1036.533559898049, 1082.426314053553, 1130.7681925205313, 10664.893351066545, 11279.548818047351, 11282.717932051764, 11290.379029153311, 11351.489182986785, 453580.0, 455529.0, 457090.0, 490318.0, 497939.0, 49058.50941490539, 76595.61702191453, 79973.60013200014, 82224.58887705523, 84478.15521844826, 1034.1519953637944, 1035.409816404642, 1043.7234132954773, 1054.1777413617237, 1065.195777188218, 16883.240254188346, 16980.660386791948, 17390.391336303168, 17573.912130439778, 17787.644247115244, 30757.0, 37985.81007094947, 39247.41128883126, 39759.60240397559, 40758.1848363037, 51007.0, 52299.47700522946, 52805.47194528006, 52855.73572132115, 52953.7352313236, 7580.810479738051, 7878.606069696607, 8095.878561821695, 8474.872876906727, 9073.45559266446, 10072.0, 13501.72996540044, 13511.324433778074, 13863.722725545635, 13931.512397066459, 11865.288082715064, 11965.581204657796, 12007.75984480288, 12063.81904271419, 12088.818667720167, 11687.163009639116, 11695.473703683185, 11877.82183267269, 11881.227720198505, 12222.877771222174, 11764.764704706029, 11768.293902365886, 12104.636860894187, 12195.75608487843, 12470.314132722788, 8006.599670016592, 8026.919730802851, 8043.798905027421, 8076.71731489395, 8140.918590814016, 11494.252873563191, 12099.879001209874, 12119.212251203644, 12227.572034978733, 12262.87737122653], "value": 9258.610637432708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.0831192972284, 1525.5652139140343, 1693.6358682883179, 1799.7660304160456, 1829.5334689654144, 7976.92023079769, 8328.45865018775, 8608.483490990537, 9200.1719845214, 9201.539923003847, 8621.913780862189, 8667.13328667133, 8700.651973921036, 8726.258268047208, 8763.298936085113, 2232.274510783998, 2252.4594097416584, 2265.105283413051, 2265.5129147233342, 2272.1820144747876, 2213.6347502662043, 2223.7442694090146, 2265.6148454762647, 2265.8527195732227, 2265.9660105098355, 2245.236619549353, 2247.83141264405, 2251.0883092347544, 2256.3343813575034, 2263.818894488437, 2208.6134926387817, 2209.2488553891594, 2230.6877037214804, 2236.2955668964305, 2237.183428048767, 2094.0786054136283, 2104.4738815296178, 2107.2729908181655, 2109.08254909115, 2111.1660893946805, 8573.699920502753, 8633.740987770314, 8656.177663121993, 8658.090900455487, 8679.43583667066, 5290.55030322423, 5417.810376636839, 5424.376196737387, 5437.0, 5452.482014208644, 3190.601174853143, 3276.918077048093, 3394.117529442338, 3396.677315655009, 3418.060033490785, 1112.3603927741501, 1140.634996801024, 1161.9360935148563, 1162.7441962768178, 1171.5138217639756, 12882.227066376048, 12914.87085129146, 12939.0, 12940.741185176244, 12956.352182390938, 4710.26990816424, 4714.693544919638, 4816.927746083811, 4828.2998965150555, 4926.211806111005, 10539.0, 10560.155187584975, 10579.523921423555, 10583.894161058444, 10587.311824731369, 5349.893002139936, 5427.294451721251, 5439.564834813205, 5452.291202143775, 5464.26232458621, 4354.608085272341, 4689.648276379286, 4830.516948305141, 4993.7503124843615, 5007.899842003212, 4111.588841115924, 4144.659443867373, 4199.139176468817, 4212.220739163265, 4271.124419493996, 1312.744014917082, 1333.2267284974691, 1337.4182230729664, 1338.6118025772612, 1342.536824795444, 816.8652172391608, 819.9754007379788, 918.8621706743908, 933.4725879877848, 938.5494962418078, 5826.0678291474005, 5838.649681019152, 5882.088276317178, 6046.606970546901, 6059.454649081604, 447.6351773304746, 452.2515237282303, 452.9501754806969, 951.7002144324516, 1037.6523864505325, 3775.244951009809, 3839.212961342918, 3846.576876543578, 3867.497225360685, 3880.495535580413, 10950.452477376099, 11153.0, 11165.888341116648, 11250.381229032482, 11262.605808796652, 10812.405317707444, 11163.106951443864, 11174.27367221128, 11183.72040698989, 11226.831597525881, 8308.459950103224, 8312.709055183039, 8334.541600212047, 8419.284360829275, 8435.957820210982, 5748.856278593069, 5764.279465066867, 5870.26621672291, 5898.646081234968, 5934.662176571713, 10057.145142662956, 10260.743481413025, 10281.12610428122, 10304.845427318447, 10406.791864162826, 9698.56356463975, 10112.08991190767, 10182.796344073226, 10259.897401025893, 10322.48387580633, 7778.031378075104, 7850.0972388173805, 7956.761297161094, 7970.4022198336515, 7978.640961156646, 8292.253697167283, 8356.498610083414, 8375.706850260212, 8390.538520381439, 8396.832063358577, 7482.513636613603, 7618.123915749759, 7703.576303303372, 7786.571738554434, 7839.216078392115, 7384.889226661497, 7451.180370159386, 7474.663640136316, 7549.50928189666, 7553.357964573072, 6923.861522769617, 6954.687039083355, 6974.68613912365, 6997.1253593300835, 7007.754728584475, 4956.975215123901, 5053.444121146597, 5072.264521644414, 5173.560247378864, 5179.896402071862, 5170.974145129401, 5172.948270517397, 5212.765425555935, 5285.312909321764, 5297.470252974672], "value": 4593.273546923559, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.39346530120724, 342.3119529745212, 344.7104432276887, 348.59040627262976, 354.765854536006, 5531.889362212758, 5537.750801213945, 5581.5255703265275, 5610.438956104393, 5627.818158186776, 5523.585731070176, 5529.557635389169, 5532.806351777688, 5560.944390556093, 5620.606557540974, 4138.565450627686, 4362.5637436256275, 4371.67204467578, 4405.207062728708, 4432.15789000089, 4218.881996270975, 4369.912601747963, 4377.277749171383, 4406.0, 4412.47050353958, 4323.935140972888, 4329.826806927719, 4337.436133302666, 4339.956600434002, 4390.319500477415, 4306.0526684129445, 4372.584604462571, 4383.824647014116, 4389.23188442023, 4403.9559604404185, 3867.361885288924, 3867.671247943928, 3869.361555343365, 3877.592852750477, 3886.24218277436, 5302.840914772563, 5363.919541206885, 5369.301990741218, 5371.892562148735, 5391.245225668409, 4972.254161875711, 5007.148784706572, 5014.824481143142, 5016.372953380827, 5017.222330538772, 5504.311961004874, 5743.167240750068, 5771.826845194651, 5791.247137872049, 5791.82624521265, 4137.420761093449, 4158.958410415918, 4173.227952828736, 4179.644730197937, 4187.644050255732, 5770.182392546334, 6028.879422411571, 6096.085587161917, 6116.143739876421, 6172.722227499773, 4201.6554702494905, 4202.054537728986, 4205.789710514462, 4222.113356195172, 4241.321388577812, 4284.507281662586, 4290.935635965463, 4299.140171965557, 4323.135372925428, 4326.2212801696, 4912.582430493448, 4940.1601727706375, 4950.529699678525, 4954.355933728664, 4969.35398398206, 5575.665460072328, 5864.739081097585, 5873.882522349614, 5885.61743486672, 5892.941070589325, 1464.9452394276318, 1494.2902121492205, 1495.9326830292664, 1505.4881340344336, 1517.4157949189641, 919.0212423768666, 944.891337496183, 951.7810903492235, 964.1419136968104, 972.3145182646359, 5124.154514505065, 5621.718914054362, 5800.767969281266, 5815.302163740378, 5828.708564571754, 5944.108383742387, 6088.0, 6105.572609917263, 6143.631382116998, 6154.569180157436, 5562.082256427725, 5739.426057394311, 5821.0, 5854.941450585525, 5862.384449632812, 3168.651448340681, 3177.698118678722, 3232.175795172216, 3243.4810430331504, 3259.869605215812, 6366.6180029198395, 6367.681615919186, 6381.2031841054495, 6381.968090159612, 6404.519661025442, 5908.940910590839, 6101.816945491642, 6156.230471191101, 6221.440070393686, 6230.190075290183, 6203.7828675996125, 6215.471684906744, 6259.873222819845, 6305.873882522324, 6332.511859712964, 5930.733117009831, 5979.880402391841, 6038.63768173911, 6073.0, 6089.969550152221, 5992.0712289595185, 5993.490553303018, 5995.370486099071, 6012.368701286302, 6043.8186854394435, 6091.9086213707715, 6242.3133455320785, 6339.017452294902, 6358.427741503287, 6370.872582548231, 4294.957050429456, 4311.3964045034345, 4322.502912165141, 4327.826886924488, 4338.761368124658, 6149.538784591263, 6150.7847225346895, 6165.630062196283, 6173.228346456693, 6195.349488303844, 5790.739416726342, 5910.822675319747, 5929.940700593112, 5935.762569497172, 5997.280326360865, 5860.970695146497, 5873.4126587340925, 5878.911816322673, 5887.646741195542, 5897.174395584536, 5272.499112584298, 5845.941540584709, 5853.882922341614, 5855.03856208158, 5877.265341832271, 5864.882702346014, 5869.7945571904775, 5887.852803679943, 5924.289085309791, 5926.288845338587, 5774.942250577608, 5832.212651292021, 5856.3558008618165, 5861.882762344814, 5915.940840591711], "value": 4479.185654847755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.277038805612, 718.7412531488665, 762.2796457347802, 774.4733581164808, 816.4203415574941, 13571.0, 13876.306184690762, 14774.704505909875, 14877.18175500347, 14907.701845963087, 14000.859991400082, 14077.50728724495, 14078.507252246174, 14090.36593353299, 14131.0, 807.4025221336213, 807.6325272001254, 811.5130921447144, 813.6663967773214, 839.4333824668355, 825.2160447574798, 827.9586020698971, 828.9461185022984, 830.6262182018116, 831.4387788242942, 863.6804382378498, 869.995650021749, 874.2175752701329, 874.2656168818191, 876.3120950054209, 863.7279257034014, 867.1631875240361, 868.4008034456268, 868.7393781865416, 870.2428886868433, 627.4572494792018, 628.2555172121051, 628.3245511075612, 629.6662768732579, 630.2279707358495, 14345.569632911029, 14534.05528640635, 14543.636409089751, 14556.927215363961, 14589.927050364786, 14042.297885105805, 14166.858331416657, 14388.136711797326, 14542.636434089232, 14552.563423097325, 11803.645890623295, 12038.277703337828, 12089.93955030228, 12119.697007574881, 12297.077719171099, 3720.8837348795255, 3750.3999360102252, 3916.8824935251705, 3968.0476685595536, 3969.8412063517426, 73022.0, 74679.62660186719, 74741.0, 75065.0, 75082.62458687671, 10747.946260268649, 10749.570017199381, 11055.944720276348, 11073.224874258725, 11149.777004459866, 18011.459656210074, 18078.09609519545, 18132.365367212085, 18152.63694726098, 18233.635327293647, 8104.675812967415, 8215.876761848576, 8239.299659529008, 8539.914600853912, 8703.695370661997, 4482.820687172477, 4506.684532082722, 4512.309006735672, 4582.633389328846, 4633.142868569325, 3468.9132771680406, 3590.605033446371, 3594.8202589870402, 3602.495650608917, 3613.512175856278, 593.1666009257001, 597.725046478616, 598.1536126381209, 605.0651743056987, 614.4961131871911, 715.6815217228387, 732.0995175933632, 736.3777607921298, 739.3161325773638, 745.5563939456015, 9276.953615231881, 9300.39547429415, 9444.480553569481, 9544.475053872104, 9660.17888479473, 573.7819628541212, 641.9358064193636, 718.547315191426, 720.8197950512372, 722.3318430451811, 4207.957920420818, 4279.144171165779, 4333.198358303724, 4360.520342762294, 4399.956000440018, 105043.0, 106838.46580767202, 107733.0, 119051.09489051199, 119179.40410298067, 58457.70771146117, 92627.51607387418, 98281.50859245658, 101040.0, 101679.491602543, 53700.73149634227, 55999.440005600234, 60830.0, 88696.556517217, 89772.10227897768, 8163.0, 8232.17678232172, 8285.792855178668, 8711.738647840575, 8891.510966896883, 51203.743981279855, 52226.477735222164, 52387.21419178639, 52496.21255681244, 53172.20241696455, 65687.34312656813, 73119.26880731338, 73270.0, 73510.26489735034, 73890.26109738834, 10237.641682541076, 10361.326513776581, 10402.427866467417, 10556.472176390997, 10934.070603998749, 12289.324087174933, 12574.182678126259, 12668.936655316664, 12670.556530521388, 12675.429605667583, 10148.289619726844, 10483.528241229316, 10887.292325998786, 10940.656815750888, 11096.722581935515, 11674.649760507198, 11842.82235766447, 11844.763104737685, 11880.579250148643, 12545.749085018431, 11775.0, 11822.586209482626, 11958.103142264192, 12113.091518136, 12631.11582189238, 9834.0, 10055.0, 10204.540795664065, 10268.229882758973, 10314.071733544017, 9569.521523923915, 9845.163161131384, 9849.704508864745, 9919.801603967735, 9943.850842237516], "value": 7138.600083402149, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 161.0, 176.0, 136.0, 161.0, 150.0, 135.0, 188.0, 125.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 164.0, 174.0, 163.0, 162.0, 160.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 157.0, 77.0, 75.0, 75.0, 75.0, 165.0, 77.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 147.0, 84.0, 84.0, 84.0, 150.0, 84.0, 84.0, 146.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 150.0, 147.0, 146.0, 147.0, 148.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 100.0, 95.0, 95.0, 96.0, 96.0, 100.0, 96.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 52.0, 56.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 64.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 79.0, 80.0, 81.0, 86.0, 82.0, 80.0, 109.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 124.0, 128.0, 132.0, 122.0, 130.0, 121.0, 145.0, 124.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 158.0, 165.0, 160.0, 159.0, 160.0, 157.0, 157.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 71.0, 64.0, 62.0, 62.0, 69.0, 61.0], "value": 64.1, "unit": "score"}]}]} 11:41:03 INFO - Return code: 0 11:41:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:41:03 ERROR - # TBPL SUCCESS # 11:41:03 INFO - Running post-action listener: _resource_record_post_action 11:41:03 INFO - ##### 11:41:03 INFO - ##### Finished run-tests step (success) 11:41:03 INFO - ##### 11:41:03 INFO - Running post-run listener: _resource_record_post_run 11:41:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539820032; Read time: 12; Write time: 606444 11:41:03 INFO - TinderboxPrint: CPU usage
13.4% 11:41:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:41:03 INFO - TinderboxPrint: I/O write bytes / time
539,820,032 / 606,444 11:41:03 INFO - TinderboxPrint: CPU idle
8,224.3 (86.5%) 11:41:03 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 11:41:03 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 222781440; Read time: 0; Write time: 277732 11:41:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289660928; Read time: 12; Write time: 323808 11:41:04 INFO - Running post-run listener: _upload_blobber_files 11:41:04 INFO - Blob upload gear active. 11:41:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:41:04 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'] 11:41:04 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 11:41:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:08 INFO - (blobuploader) - INFO - Done attempting. 11:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:09 INFO - (blobuploader) - INFO - Done attempting. 11:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:09 INFO - (blobuploader) - INFO - Done attempting. 11:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:09 INFO - Return code: 0 11:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d585a2f06b4619668036a03e023ec1e8a9ef88eabfbfeaad2b5f67f289a32f5b8da839bc8dedeb6e85896f02057d66d811b6af78de86b6f2e44de79c9824f85d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb497576d9956a6017c2908a7f7ba19f286b99144735e4d7532dd1db001b5566d6748de7840151def01993a14f24f800bb29981a8985e58ea441f31a43a700a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7bd706fccf3cd619cbde9df9e816eb2e0a2e2bcd8e46acbae3c7112fb1e6c8b4eb27b409159b31b76429bd5f00602881686808227677dd458a0d3ddfb10fc97"} 11:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:09 INFO - Contents: 11:41:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d585a2f06b4619668036a03e023ec1e8a9ef88eabfbfeaad2b5f67f289a32f5b8da839bc8dedeb6e85896f02057d66d811b6af78de86b6f2e44de79c9824f85d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb497576d9956a6017c2908a7f7ba19f286b99144735e4d7532dd1db001b5566d6748de7840151def01993a14f24f800bb29981a8985e58ea441f31a43a700a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7bd706fccf3cd619cbde9df9e816eb2e0a2e2bcd8e46acbae3c7112fb1e6c8b4eb27b409159b31b76429bd5f00602881686808227677dd458a0d3ddfb10fc97"} 11:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:09 INFO - Copying logs to upload dir... 11:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.965147 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-02 11:41:09.877300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 11:41:09.880850) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d585a2f06b4619668036a03e023ec1e8a9ef88eabfbfeaad2b5f67f289a32f5b8da839bc8dedeb6e85896f02057d66d811b6af78de86b6f2e44de79c9824f85d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb497576d9956a6017c2908a7f7ba19f286b99144735e4d7532dd1db001b5566d6748de7840151def01993a14f24f800bb29981a8985e58ea441f31a43a700a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7bd706fccf3cd619cbde9df9e816eb2e0a2e2bcd8e46acbae3c7112fb1e6c8b4eb27b409159b31b76429bd5f00602881686808227677dd458a0d3ddfb10fc97"} build_url:https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d585a2f06b4619668036a03e023ec1e8a9ef88eabfbfeaad2b5f67f289a32f5b8da839bc8dedeb6e85896f02057d66d811b6af78de86b6f2e44de79c9824f85d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb497576d9956a6017c2908a7f7ba19f286b99144735e4d7532dd1db001b5566d6748de7840151def01993a14f24f800bb29981a8985e58ea441f31a43a700a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7bd706fccf3cd619cbde9df9e816eb2e0a2e2bcd8e46acbae3c7112fb1e6c8b4eb27b409159b31b76429bd5f00602881686808227677dd458a0d3ddfb10fc97"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 11:41:09.905401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:41:09.905716) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464890004.260613-394618992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:41:09.991500) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 11:41:09.991826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 11:41:09.992128) ========= ========= Total master_lag: 0.37 =========