builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1464892233.29 results: success (0) buildid: 20160602083053 builduid: 34356c4fc4a746598981ec065b23e308 revision: 60b8c047de4c4551de50cb1f088615d49c2370c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.289775) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.290229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.290518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.306903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.307160) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 11:30:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2016-06-02 11:30:33 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071980 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.395321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.395649) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015819 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.445211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:33.445606) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 11:30:33,635 truncating revision to first 12 chars 2016-06-02 11:30:33,635 Setting DEBUG logging. 2016-06-02 11:30:33,635 attempt 1/10 2016-06-02 11:30:33,635 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:30:34,092 unpacking tar archive at: fx-team-60b8c047de4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.798437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:34.256717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:34.257007) ========= script_repo_revision: 60b8c047de4c4551de50cb1f088615d49c2370c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:34.257376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:34.257666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:30:34.268394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-02 11:30:34.268796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:30:34 INFO - MultiFileLogger online at 20160602 11:30:34 in /builds/slave/test 11:30:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:30:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:30:34 INFO - {'append_to_log': False, 11:30:34 INFO - 'base_work_dir': '/builds/slave/test', 11:30:34 INFO - 'blob_upload_branch': 'Fx-Team', 11:30:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:30:34 INFO - 'branch': 'Fx-Team', 11:30:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:30:34 INFO - 'config_files': ('talos/linux_config.py',), 11:30:34 INFO - 'default_actions': ('clobber', 11:30:34 INFO - 'read-buildbot-config', 11:30:34 INFO - 'download-and-extract', 11:30:34 INFO - 'populate-webroot', 11:30:34 INFO - 'create-virtualenv', 11:30:34 INFO - 'install', 11:30:34 INFO - 'run-tests'), 11:30:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:30:34 INFO - 'download_minidump_stackwalk': True, 11:30:34 INFO - 'download_symbols': 'ondemand', 11:30:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:30:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:30:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:30:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:30:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:30:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:30:34 INFO - 'installer_path': 'installer.exe', 11:30:34 INFO - 'log_level': 'info', 11:30:34 INFO - 'log_name': 'talos', 11:30:34 INFO - 'log_to_console': True, 11:30:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:30:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:30:34 INFO - 'opt_config_files': (), 11:30:34 INFO - 'pip_index': False, 11:30:34 INFO - 'sps_profile': False, 11:30:34 INFO - 'sps_profile_interval': 0, 11:30:34 INFO - 'suite': 'dromaeojs', 11:30:34 INFO - 'system_bits': '32', 11:30:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:30:34 INFO - 'title': 'talos-linux64-ix-059', 11:30:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:30:34 INFO - 'use_talos_json': True, 11:30:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:30:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:30:34 INFO - 'work_dir': 'build'} 11:30:34 INFO - ##### 11:30:34 INFO - ##### Running clobber step. 11:30:34 INFO - ##### 11:30:34 INFO - Running pre-action listener: _resource_record_pre_action 11:30:34 INFO - Running main action method: clobber 11:30:34 INFO - rmtree: /builds/slave/test/build 11:30:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:30:35 INFO - Running post-action listener: _resource_record_post_action 11:30:35 INFO - ##### 11:30:35 INFO - ##### Finished clobber step (success) 11:30:35 INFO - ##### 11:30:35 INFO - ##### 11:30:35 INFO - ##### Running read-buildbot-config step. 11:30:35 INFO - ##### 11:30:35 INFO - Running pre-action listener: _resource_record_pre_action 11:30:35 INFO - Running main action method: read_buildbot_config 11:30:35 INFO - Using buildbot properties: 11:30:35 INFO - { 11:30:35 INFO - "project": "", 11:30:35 INFO - "product": "firefox", 11:30:35 INFO - "script_repo_revision": "production", 11:30:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:30:35 INFO - "repository": "", 11:30:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:30:35 INFO - "buildid": "20160602083053", 11:30:35 INFO - "pgo_build": "True", 11:30:35 INFO - "basedir": "/builds/slave/test", 11:30:35 INFO - "buildnumber": 757, 11:30:35 INFO - "slavename": "talos-linux64-ix-059", 11:30:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:30:35 INFO - "platform": "ubuntu64_hw", 11:30:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:30:35 INFO - "branch": "fx-team", 11:30:35 INFO - "repo_path": "integration/fx-team", 11:30:35 INFO - "revision": "60b8c047de4c4551de50cb1f088615d49c2370c5", 11:30:35 INFO - "stage_platform": "linux64-pgo", 11:30:35 INFO - "builduid": "34356c4fc4a746598981ec065b23e308", 11:30:35 INFO - "slavebuilddir": "test" 11:30:35 INFO - } 11:30:35 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:30:35 INFO - Running post-action listener: _resource_record_post_action 11:30:35 INFO - ##### 11:30:35 INFO - ##### Finished read-buildbot-config step (success) 11:30:35 INFO - ##### 11:30:35 INFO - ##### 11:30:35 INFO - ##### Running download-and-extract step. 11:30:35 INFO - ##### 11:30:35 INFO - Running pre-action listener: _resource_record_pre_action 11:30:35 INFO - Running main action method: download_and_extract 11:30:35 INFO - mkdir: /builds/slave/test/build/tests 11:30: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:30:35 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:30: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.test_packages.json 11:30: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.test_packages.json 11:30: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.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:30:35 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:30:39 INFO - Downloaded 1361 bytes. 11:30:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:30:39 INFO - Using the following test package requirements: 11:30:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:30:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:30:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'jsshell-linux-x86_64.zip'], 11:30:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:30:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:30:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:30:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:30:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:30:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:39 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:30:39 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:30:39 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:30:39 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:30:39 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:30:41 INFO - Downloaded 24439748 bytes. 11:30:41 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:30:41 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:30:42 INFO - Return code: 0 11:30:42 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:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:42 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:30:42 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:30:42 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:30:42 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:30:42 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:30:45 INFO - Downloaded 24439748 bytes. 11:30:45 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:30:45 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:30:47 INFO - Return code: 0 11:30:47 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:30:47 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:30:47 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:30:47 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:30:47 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:30:47 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:30:48 INFO - Downloaded 10834055 bytes. 11:30:48 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:30:48 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:30:48 INFO - Return code: 0 11:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:48 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:30:48 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:30:48 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:30:48 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:30:48 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:30:49 INFO - Downloaded 59058520 bytes. 11:30:49 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:30:49 INFO - mkdir: /builds/slave/test/properties 11:30:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:30:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:30:49 INFO - Contents: 11:30:49 INFO - build_url:https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:30:50 INFO - Running post-action listener: _resource_record_post_action 11:30:50 INFO - Running post-action listener: set_extra_try_arguments 11:30:50 INFO - ##### 11:30:50 INFO - ##### Finished download-and-extract step (success) 11:30:50 INFO - ##### 11:30:50 INFO - ##### 11:30:50 INFO - ##### Running populate-webroot step. 11:30:50 INFO - ##### 11:30:50 INFO - Running pre-action listener: _resource_record_pre_action 11:30:50 INFO - Running main action method: populate_webroot 11:30:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:30:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:30:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:30:50 INFO - '--tppagecycles', 11:30:50 INFO - '7'], 11:30:50 INFO - 'tests': ['tsvgm']}}, 11:30:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:30:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:30:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:30:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:30:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['damp', 'tps']}, 11:30:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'tests': ['damp', 'tps']}, 11:30:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['dromaeo_dom']}, 11:30:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['a11yr', 11:30:50 INFO - 'ts_paint', 11:30:50 INFO - 'tpaint', 11:30:50 INFO - 'sessionrestore', 11:30:50 INFO - 'sessionrestore_no_auto_restore', 11:30:50 INFO - 'tabpaint']}, 11:30:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:30:50 INFO - 'ts_paint', 11:30:50 INFO - 'tpaint', 11:30:50 INFO - 'sessionrestore', 11:30:50 INFO - 'sessionrestore_no_auto_restore', 11:30:50 INFO - 'tabpaint']}, 11:30:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:30:50 INFO - 'ts_paint', 11:30:50 INFO - 'tpaint', 11:30:50 INFO - 'sessionrestore', 11:30:50 INFO - 'sessionrestore_no_auto_restore', 11:30:50 INFO - 'tabpaint']}, 11:30:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:30:50 INFO - 'ts_paint', 11:30:50 INFO - 'tpaint', 11:30:50 INFO - 'sessionrestore', 11:30:50 INFO - 'sessionrestore_no_auto_restore', 11:30:50 INFO - 'tabpaint']}, 11:30:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['a11yr', 11:30:50 INFO - 'ts_paint', 11:30:50 INFO - 'tpaint', 11:30:50 INFO - 'sessionrestore', 11:30:50 INFO - 'sessionrestore_no_auto_restore', 11:30:50 INFO - 'tabpaint']}, 11:30:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['a11yr', 11:30:50 INFO - 'ts_paint', 11:30:50 INFO - 'tpaint', 11:30:50 INFO - 'sessionrestore', 11:30:50 INFO - 'sessionrestore_no_auto_restore', 11:30:50 INFO - 'tabpaint']}, 11:30:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['tsvgx', 11:30:50 INFO - 'tsvgr_opacity', 11:30:50 INFO - 'tart', 11:30:50 INFO - 'tscrollx', 11:30:50 INFO - 'cart']}, 11:30:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:30:50 INFO - 'tsvgr_opacity', 11:30:50 INFO - 'tart', 11:30:50 INFO - 'tscrollx', 11:30:50 INFO - 'cart']}, 11:30:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'talos_options': ['--disable-e10s'], 11:30:50 INFO - 'tests': ['tp5o']}, 11:30:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'tests': ['tp5o']}, 11:30:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'talos_options': ['--disable-e10s', 11:30:50 INFO - '--xperf_path', 11:30:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:50 INFO - 'tests': ['tp5n']}, 11:30:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:50 INFO - 'talos_options': ['--xperf_path', 11:30:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:50 INFO - 'tests': ['tp5n']}}, 11:30:50 INFO - 'talos.zip': {'path': '', 11:30:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:30:50 INFO - Running post-action listener: _resource_record_post_action 11:30:50 INFO - ##### 11:30:50 INFO - ##### Finished populate-webroot step (success) 11:30:50 INFO - ##### 11:30:50 INFO - ##### 11:30:50 INFO - ##### Running create-virtualenv step. 11:30:50 INFO - ##### 11:30:50 INFO - Running pre-action listener: _resource_record_pre_action 11:30:50 INFO - Running main action method: create_virtualenv 11:30:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:30:50 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:30:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:30:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:50 INFO - Using real prefix '/usr' 11:30:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:30:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:53 INFO - Installing pip.................done. 11:30:53 INFO - Return code: 0 11:30:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:30: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:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:30: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', 'pip>=1.5'] in /builds/slave/test/build 11:30: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 pip>=1.5 11:30:53 INFO - Using env: {'DISPLAY': ':0', 11:30:53 INFO - 'HOME': '/home/cltbld', 11:30:53 INFO - 'LANG': 'en_US.UTF-8', 11:30:53 INFO - 'LANGUAGE': 'en_US:en', 11:30:53 INFO - 'LOGNAME': 'cltbld', 11:30:53 INFO - 'MAIL': '/var/mail/cltbld', 11:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:53 INFO - 'MOZ_NO_REMOTE': '1', 11:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:53 INFO - 'NO_EM_RESTART': '1', 11:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:53 INFO - 'PWD': '/builds/slave/test', 11:30:53 INFO - 'SHELL': '/bin/bash', 11:30:53 INFO - 'SHLVL': '1', 11:30:53 INFO - 'TERM': 'linux', 11:30:53 INFO - 'TMOUT': '86400', 11:30:53 INFO - 'USER': 'cltbld', 11:30:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:53 INFO - '_': '/tools/buildbot/bin/python'} 11:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:53 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:30:53 INFO - Cleaning up... 11:30:53 INFO - Return code: 0 11:30:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:30: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:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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', '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 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:30: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 psutil>=3.1.1 11:30:53 INFO - Using env: {'DISPLAY': ':0', 11:30:53 INFO - 'HOME': '/home/cltbld', 11:30:53 INFO - 'LANG': 'en_US.UTF-8', 11:30:53 INFO - 'LANGUAGE': 'en_US:en', 11:30:53 INFO - 'LOGNAME': 'cltbld', 11:30:53 INFO - 'MAIL': '/var/mail/cltbld', 11:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:53 INFO - 'MOZ_NO_REMOTE': '1', 11:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:53 INFO - 'NO_EM_RESTART': '1', 11:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:53 INFO - 'PWD': '/builds/slave/test', 11:30:53 INFO - 'SHELL': '/bin/bash', 11:30:53 INFO - 'SHLVL': '1', 11:30:53 INFO - 'TERM': 'linux', 11:30:53 INFO - 'TMOUT': '86400', 11:30:53 INFO - 'USER': 'cltbld', 11:30:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:53 INFO - '_': '/tools/buildbot/bin/python'} 11:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:53 INFO - Downloading/unpacking psutil>=3.1.1 11:30: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:30: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:30: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:30: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:30: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:30: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:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:55 INFO - Installing collected packages: psutil 11:30:55 INFO - Running setup.py install for psutil 11:30:55 INFO - building 'psutil._psutil_linux' extension 11:30:55 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:30:55 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:30:55 INFO - building 'psutil._psutil_posix' extension 11:30:55 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:30:56 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:30:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:56 INFO - Successfully installed psutil 11:30:56 INFO - Cleaning up... 11:30:56 INFO - Return code: 0 11:30:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:30:56 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:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:56 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:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:56 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 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:30:56 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:30:56 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:30:56 INFO - Using env: {'DISPLAY': ':0', 11:30:56 INFO - 'HOME': '/home/cltbld', 11:30:56 INFO - 'LANG': 'en_US.UTF-8', 11:30:56 INFO - 'LANGUAGE': 'en_US:en', 11:30:56 INFO - 'LOGNAME': 'cltbld', 11:30:56 INFO - 'MAIL': '/var/mail/cltbld', 11:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:56 INFO - 'MOZ_NO_REMOTE': '1', 11:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:56 INFO - 'NO_EM_RESTART': '1', 11:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:56 INFO - 'PWD': '/builds/slave/test', 11:30:56 INFO - 'SHELL': '/bin/bash', 11:30:56 INFO - 'SHLVL': '1', 11:30:56 INFO - 'TERM': 'linux', 11:30:56 INFO - 'TMOUT': '86400', 11:30:56 INFO - 'USER': 'cltbld', 11:30:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:56 INFO - '_': '/tools/buildbot/bin/python'} 11:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:30:56 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:30:56 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:30:56 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:30:56 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:30:56 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:30:56 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:30:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:30:58 INFO - Installing collected packages: mozsystemmonitor 11:30:58 INFO - Running setup.py install for mozsystemmonitor 11:30:58 INFO - Successfully installed mozsystemmonitor 11:30:58 INFO - Cleaning up... 11:30:58 INFO - Return code: 0 11:30:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:30:58 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:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:58 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:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:58 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 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:30:58 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:30:58 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:30:58 INFO - Using env: {'DISPLAY': ':0', 11:30:58 INFO - 'HOME': '/home/cltbld', 11:30:58 INFO - 'LANG': 'en_US.UTF-8', 11:30:58 INFO - 'LANGUAGE': 'en_US:en', 11:30:58 INFO - 'LOGNAME': 'cltbld', 11:30:58 INFO - 'MAIL': '/var/mail/cltbld', 11:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:58 INFO - 'MOZ_NO_REMOTE': '1', 11:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:58 INFO - 'NO_EM_RESTART': '1', 11:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:58 INFO - 'PWD': '/builds/slave/test', 11:30:58 INFO - 'SHELL': '/bin/bash', 11:30:58 INFO - 'SHLVL': '1', 11:30:58 INFO - 'TERM': 'linux', 11:30:58 INFO - 'TMOUT': '86400', 11:30:58 INFO - 'USER': 'cltbld', 11:30:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:58 INFO - '_': '/tools/buildbot/bin/python'} 11:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:30: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:30: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:30: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:30: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:30: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:30: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:31:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:00 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:31:00 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:31:00 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:31:00 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:31:00 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:31:00 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:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:01 INFO - Downloading docopt-0.6.1.tar.gz 11:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:01 INFO - Running setup.py install for blobuploader 11:31:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:01 INFO - Running setup.py install for requests 11:31:01 INFO - Running setup.py install for docopt 11:31:01 INFO - Successfully installed blobuploader requests docopt 11:31:01 INFO - Cleaning up... 11:31:01 INFO - Return code: 0 11:31:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:01 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 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:31:01 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:31:01 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:31:01 INFO - Using env: {'DISPLAY': ':0', 11:31:01 INFO - 'HOME': '/home/cltbld', 11:31:01 INFO - 'LANG': 'en_US.UTF-8', 11:31:01 INFO - 'LANGUAGE': 'en_US:en', 11:31:01 INFO - 'LOGNAME': 'cltbld', 11:31:01 INFO - 'MAIL': '/var/mail/cltbld', 11:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:01 INFO - 'MOZ_NO_REMOTE': '1', 11:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:01 INFO - 'NO_EM_RESTART': '1', 11:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:01 INFO - 'PWD': '/builds/slave/test', 11:31:01 INFO - 'SHELL': '/bin/bash', 11:31:01 INFO - 'SHLVL': '1', 11:31:01 INFO - 'TERM': 'linux', 11:31:01 INFO - 'TMOUT': '86400', 11:31:01 INFO - 'USER': 'cltbld', 11:31:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:01 INFO - '_': '/tools/buildbot/bin/python'} 11:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:02 INFO - Running setup.py (path:/tmp/pip-Vn98B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:02 INFO - Running setup.py (path:/tmp/pip-jfMQHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:02 INFO - Running setup.py (path:/tmp/pip-lIiDHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:02 INFO - Running setup.py (path:/tmp/pip-oq9K9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:02 INFO - Running setup.py (path:/tmp/pip-hn4y8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:02 INFO - Running setup.py (path:/tmp/pip-gQvVNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:02 INFO - Running setup.py (path:/tmp/pip-ZiAQiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:02 INFO - Running setup.py (path:/tmp/pip-MFktIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:02 INFO - Running setup.py (path:/tmp/pip-DpXOKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:02 INFO - Running setup.py (path:/tmp/pip-rFPILR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:02 INFO - Running setup.py (path:/tmp/pip-vgb0ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:02 INFO - Running setup.py (path:/tmp/pip-Xx1Vkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:03 INFO - Running setup.py (path:/tmp/pip-qEDsF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:03 INFO - Running setup.py (path:/tmp/pip-tcsrwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:03 INFO - Running setup.py (path:/tmp/pip-H5Js0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:03 INFO - Running setup.py (path:/tmp/pip-_HkSSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:03 INFO - Running setup.py (path:/tmp/pip-BbNQjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:03 INFO - Running setup.py install for manifestparser 11:31:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for mozcrash 11:31:03 INFO - Running setup.py install for mozdebug 11:31:03 INFO - Running setup.py install for mozdevice 11:31:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for mozfile 11:31:03 INFO - Running setup.py install for mozhttpd 11:31:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozinfo 11:31:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozInstall 11:31:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozleak 11:31:04 INFO - Running setup.py install for mozlog 11:31:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for moznetwork 11:31:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozprocess 11:31:04 INFO - Running setup.py install for mozprofile 11:31:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozrunner 11:31:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozscreenshot 11:31:04 INFO - Running setup.py install for moztest 11:31:05 INFO - Running setup.py install for mozversion 11:31:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:05 INFO - Cleaning up... 11:31:05 INFO - Return code: 0 11:31:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:05 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 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:31:05 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:31:05 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:31:05 INFO - Using env: {'DISPLAY': ':0', 11:31:05 INFO - 'HOME': '/home/cltbld', 11:31:05 INFO - 'LANG': 'en_US.UTF-8', 11:31:05 INFO - 'LANGUAGE': 'en_US:en', 11:31:05 INFO - 'LOGNAME': 'cltbld', 11:31:05 INFO - 'MAIL': '/var/mail/cltbld', 11:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:05 INFO - 'MOZ_NO_REMOTE': '1', 11:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:05 INFO - 'NO_EM_RESTART': '1', 11:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:05 INFO - 'PWD': '/builds/slave/test', 11:31:05 INFO - 'SHELL': '/bin/bash', 11:31:05 INFO - 'SHLVL': '1', 11:31:05 INFO - 'TERM': 'linux', 11:31:05 INFO - 'TMOUT': '86400', 11:31:05 INFO - 'USER': 'cltbld', 11:31:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:05 INFO - '_': '/tools/buildbot/bin/python'} 11:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:05 INFO - Running setup.py (path:/tmp/pip-fVBHcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:05 INFO - Running setup.py (path:/tmp/pip-MAr7z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:05 INFO - Running setup.py (path:/tmp/pip-M_gGhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:05 INFO - Running setup.py (path:/tmp/pip-AbkQiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:05 INFO - Running setup.py (path:/tmp/pip-Fp8lLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:05 INFO - Running setup.py (path:/tmp/pip-wP8aJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:05 INFO - Running setup.py (path:/tmp/pip-qLSh6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:05 INFO - Running setup.py (path:/tmp/pip-G2vxSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:05 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:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:05 INFO - Running setup.py (path:/tmp/pip-gLpLA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:06 INFO - Running setup.py (path:/tmp/pip-1SLvn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:06 INFO - Running setup.py (path:/tmp/pip-3tSAgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:06 INFO - Running setup.py (path:/tmp/pip-R86DnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:06 INFO - Running setup.py (path:/tmp/pip-FjaoH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:06 INFO - Running setup.py (path:/tmp/pip-ftMWFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:06 INFO - Running setup.py (path:/tmp/pip-fQhr4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:06 INFO - Running setup.py (path:/tmp/pip-3B277n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:06 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:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:06 INFO - Running setup.py (path:/tmp/pip-MD5X62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:06 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:31:06 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:31:06 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:31:06 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:31:06 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:31:06 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:31:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31: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:31: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:31: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:31: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:31: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:31: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:31:08 INFO - Downloading blessings-1.6.tar.gz 11:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:31:08 INFO - Installing collected packages: blessings 11:31:08 INFO - Running setup.py install for blessings 11:31:08 INFO - Successfully installed blessings 11:31:08 INFO - Cleaning up... 11:31:08 INFO - Return code: 0 11:31:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:08 INFO - Reading from file tmpfile_stdout 11:31:08 INFO - Current package versions: 11:31:08 INFO - argparse == 1.2.1 11:31:08 INFO - blessings == 1.6 11:31:08 INFO - blobuploader == 1.2.4 11:31:08 INFO - docopt == 0.6.1 11:31:08 INFO - manifestparser == 1.1 11:31:08 INFO - mozInstall == 1.12 11:31:08 INFO - mozcrash == 0.17 11:31:08 INFO - mozdebug == 0.1 11:31:08 INFO - mozdevice == 0.48 11:31:08 INFO - mozfile == 1.2 11:31:08 INFO - mozhttpd == 0.7 11:31:08 INFO - mozinfo == 0.9 11:31:08 INFO - mozleak == 0.1 11:31:08 INFO - mozlog == 3.2 11:31:08 INFO - moznetwork == 0.27 11:31:08 INFO - mozprocess == 0.22 11:31:08 INFO - mozprofile == 0.28 11:31:08 INFO - mozrunner == 6.11 11:31:08 INFO - mozscreenshot == 0.1 11:31:08 INFO - mozsystemmonitor == 0.3 11:31:08 INFO - moztest == 0.7 11:31:08 INFO - mozversion == 1.4 11:31:08 INFO - psutil == 3.1.1 11:31:08 INFO - requests == 1.2.3 11:31:08 INFO - wsgiref == 0.1.2 11:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:08 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 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:31:08 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:31:08 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:31:08 INFO - Using env: {'DISPLAY': ':0', 11:31:08 INFO - 'HOME': '/home/cltbld', 11:31:08 INFO - 'LANG': 'en_US.UTF-8', 11:31:08 INFO - 'LANGUAGE': 'en_US:en', 11:31:08 INFO - 'LOGNAME': 'cltbld', 11:31:08 INFO - 'MAIL': '/var/mail/cltbld', 11:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:08 INFO - 'MOZ_NO_REMOTE': '1', 11:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:08 INFO - 'NO_EM_RESTART': '1', 11:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:08 INFO - 'PWD': '/builds/slave/test', 11:31:08 INFO - 'SHELL': '/bin/bash', 11:31:08 INFO - 'SHLVL': '1', 11:31:08 INFO - 'TERM': 'linux', 11:31:08 INFO - 'TMOUT': '86400', 11:31:08 INFO - 'USER': 'cltbld', 11:31:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:08 INFO - '_': '/tools/buildbot/bin/python'} 11:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 INFO - Cleaning up... 11:31:09 INFO - Return code: 0 11:31:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:31: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:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:31: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', 'jsonschema'] in /builds/slave/test/build 11:31: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 jsonschema 11:31:09 INFO - Using env: {'DISPLAY': ':0', 11:31:09 INFO - 'HOME': '/home/cltbld', 11:31:09 INFO - 'LANG': 'en_US.UTF-8', 11:31:09 INFO - 'LANGUAGE': 'en_US:en', 11:31:09 INFO - 'LOGNAME': 'cltbld', 11:31:09 INFO - 'MAIL': '/var/mail/cltbld', 11:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:09 INFO - 'MOZ_NO_REMOTE': '1', 11:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:09 INFO - 'NO_EM_RESTART': '1', 11:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:09 INFO - 'PWD': '/builds/slave/test', 11:31:09 INFO - 'SHELL': '/bin/bash', 11:31:09 INFO - 'SHLVL': '1', 11:31:09 INFO - 'TERM': 'linux', 11:31:09 INFO - 'TMOUT': '86400', 11:31:09 INFO - 'USER': 'cltbld', 11:31:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:09 INFO - '_': '/tools/buildbot/bin/python'} 11:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:09 INFO - Downloading/unpacking jsonschema 11:31: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:31: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:31: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:31: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:31: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:31: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:31:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:11 INFO - Downloading/unpacking functools32 (from jsonschema) 11:31: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:31: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:31: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:31: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:31: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:31: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:31:11 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:11 INFO - warning: no files found matching '*.txt' 11:31:11 INFO - no previously-included directories found matching 'build' 11:31:11 INFO - no previously-included directories found matching 'dist' 11:31:11 INFO - no previously-included directories found matching '.git*' 11:31:11 INFO - Installing collected packages: jsonschema, functools32 11:31:11 INFO - Running setup.py install for functools32 11:31:11 INFO - warning: no files found matching '*.txt' 11:31:11 INFO - no previously-included directories found matching 'build' 11:31:11 INFO - no previously-included directories found matching 'dist' 11:31:11 INFO - no previously-included directories found matching '.git*' 11:31:11 INFO - Successfully installed jsonschema functools32 11:31:11 INFO - Cleaning up... 11:31:11 INFO - Return code: 0 11:31:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:31:11 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:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:11 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:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:11 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 0x7fa99af60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, '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': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', '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:31:11 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:31:11 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:31:11 INFO - Using env: {'DISPLAY': ':0', 11:31:11 INFO - 'HOME': '/home/cltbld', 11:31:11 INFO - 'LANG': 'en_US.UTF-8', 11:31:11 INFO - 'LANGUAGE': 'en_US:en', 11:31:11 INFO - 'LOGNAME': 'cltbld', 11:31:11 INFO - 'MAIL': '/var/mail/cltbld', 11:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:11 INFO - 'MOZ_NO_REMOTE': '1', 11:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:11 INFO - 'NO_EM_RESTART': '1', 11:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:11 INFO - 'PWD': '/builds/slave/test', 11:31:11 INFO - 'SHELL': '/bin/bash', 11:31:11 INFO - 'SHLVL': '1', 11:31:11 INFO - 'TERM': 'linux', 11:31:11 INFO - 'TMOUT': '86400', 11:31:11 INFO - 'USER': 'cltbld', 11:31:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:11 INFO - '_': '/tools/buildbot/bin/python'} 11:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:12 INFO - Downloading/unpacking flake8 11:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:31:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:31:13 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:31:13 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:31:13 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:31:13 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:31:13 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:31:13 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:31:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:31:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:31:14 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:31:14 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:31:14 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:31:14 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:31:14 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:31:14 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:31:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:31:14 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:31:14 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:31:14 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:31:14 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:31:14 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:31:14 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:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:31:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:31:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:31:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:31:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:31:14 INFO - no previously-included directories found matching 'docs/_build' 11:31:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:31:14 INFO - Running setup.py install for pep8 11:31:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:31:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:31:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:31:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:31:14 INFO - no previously-included directories found matching 'docs/_build' 11:31:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:31:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:31:14 INFO - Cleaning up... 11:31:14 INFO - Return code: 0 11:31:14 INFO - Running post-action listener: _resource_record_post_action 11:31:14 INFO - Running post-action listener: _start_resource_monitoring 11:31:14 INFO - Starting resource monitoring. 11:31:14 INFO - ##### 11:31:14 INFO - ##### Finished create-virtualenv step (success) 11:31:14 INFO - ##### 11:31:14 INFO - ##### 11:31:14 INFO - ##### Running install step. 11:31:14 INFO - ##### 11:31:14 INFO - Running pre-action listener: _resource_record_pre_action 11:31:14 INFO - Running main action method: install 11:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:15 INFO - Reading from file tmpfile_stdout 11:31:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:31:15 INFO - Reading from file tmpfile_stdout 11:31:15 INFO - Output received: 11:31:15 INFO - Usage: mozinstall [options] installer 11:31:15 INFO - Options: 11:31:15 INFO - -h, --help show this help message and exit 11:31:15 INFO - -d DEST, --destination=DEST 11:31:15 INFO - Directory to install application into. [default: 11:31:15 INFO - "/builds/slave/test"] 11:31:15 INFO - --app=APP Application being installed. [default: firefox] 11:31:15 INFO - mkdir: /builds/slave/test/build/application 11:31:15 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:31:15 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:31:31 INFO - Reading from file tmpfile_stdout 11:31:31 INFO - Output received: 11:31:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:31:31 INFO - Running post-action listener: _resource_record_post_action 11:31:31 INFO - ##### 11:31:31 INFO - ##### Finished install step (success) 11:31:31 INFO - ##### 11:31:31 INFO - ##### 11:31:31 INFO - ##### Running run-tests step. 11:31:31 INFO - ##### 11:31:31 INFO - Running pre-action listener: _resource_record_pre_action 11:31:31 INFO - Running main action method: run_tests 11:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:31:31 INFO - Python 2.7.3 11:31:31 INFO - Return code: 0 11:31:31 INFO - grabbing minidump binary from tooltool 11:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:31 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 0x26ed9c0>, '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 0x26ee8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:31:31 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:31:31 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:31:31 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:31:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:31:32 INFO - Return code: 0 11:31:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:31:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:31:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:31:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:31:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:31:32 INFO - Return code: 0 11:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:31:32 INFO - Using env: {'DISPLAY': ':0', 11:31:32 INFO - 'HOME': '/home/cltbld', 11:31:32 INFO - 'LANG': 'en_US.UTF-8', 11:31:32 INFO - 'LANGUAGE': 'en_US:en', 11:31:32 INFO - 'LOGNAME': 'cltbld', 11:31:32 INFO - 'MAIL': '/var/mail/cltbld', 11:31:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:32 INFO - 'MOZ_NO_REMOTE': '1', 11:31:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:32 INFO - 'NO_EM_RESTART': '1', 11:31:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:32 INFO - 'PWD': '/builds/slave/test', 11:31:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:32 INFO - 'SHELL': '/bin/bash', 11:31:32 INFO - 'SHLVL': '1', 11:31:32 INFO - 'TERM': 'linux', 11:31:32 INFO - 'TMOUT': '86400', 11:31:32 INFO - 'USER': 'cltbld', 11:31:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029', 11:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:32 INFO - '_': '/tools/buildbot/bin/python'} 11:31:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJYwIuT9Q7G7r0t4nehGew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:31:33 INFO - mozversion application_buildid: 20160602083053 11:31:33 INFO - mozversion application_changeset: 60b8c047de4c4551de50cb1f088615d49c2370c5 11:31:33 INFO - mozversion application_display_name: Nightly 11:31:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:33 INFO - mozversion application_name: Firefox 11:31:33 INFO - mozversion application_remotingname: firefox 11:31:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:31:33 INFO - mozversion application_vendor: Mozilla 11:31:33 INFO - mozversion application_version: 49.0a1 11:31:33 INFO - mozversion platform_buildid: 20160602083053 11:31:33 INFO - mozversion platform_changeset: 60b8c047de4c4551de50cb1f088615d49c2370c5 11:31:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:31:33 INFO - mozversion platform_version: 49.0a1 11:31:33 INFO - using testdate: 1464892293 11:31:33 INFO - actual date: 1464892293 11:31:33 INFO - starting webserver on 'localhost:35143' 11:31:33 INFO - SUITE-START | Running 2 tests 11:31:33 INFO - TEST-START | dromaeo_css 11:31:33 INFO - operating with platform_type : linux_ 11:31:33 INFO - Initialising browser for dromaeo_css test... 11:31:33 INFO - TEST-INFO | started process 13027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLlRWiC/profile http://localhost:35143/getInfo.html) 11:31:37 INFO - PROCESS | 13027 | __metrics Screen width/height:1600/1200 11:31:37 INFO - PROCESS | 13027 | colorDepth:24 11:31:37 INFO - PROCESS | 13027 | Browser inner width/height: 1024/697 11:31:37 INFO - PROCESS | 13027 | __metrics 11:31:38 ERROR - PROCESS | 13027 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:31:38 INFO - TEST-INFO | 13027: exit 0 11:31:38 INFO - Browser initialized. 11:31:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:38 INFO - TEST-INFO | started process 13113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLlRWiC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:50 INFO - PROCESS | 13113 | RSS: Main: 156037120 11:31:50 INFO - PROCESS | 13113 | 11:32:41 INFO - PROCESS | 13113 | 1464892361853 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:34:49 INFO - PROCESS | 13113 | Cycle 1(1): loaded http://localhost:35143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35143/tests/dromaeo/cssquery-ext.html) 11:34:50 INFO - PROCESS | 13113 | RSS: Main: 243019776 11:34:50 INFO - PROCESS | 13113 | 11:37:53 INFO - PROCESS | 13113 | Cycle 1(1): loaded http://localhost:35143/tests/dromaeo/cssquery-ext.html (next: http://localhost:35143/tests/dromaeo/cssquery-jquery.html) 11:37:53 INFO - PROCESS | 13113 | RSS: Main: 246284288 11:37:53 INFO - PROCESS | 13113 | 11:40:55 INFO - PROCESS | 13113 | Cycle 1(1): loaded http://localhost:35143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35143/tests/dromaeo/cssquery-mootools.html) 11:40:56 INFO - PROCESS | 13113 | RSS: Main: 245579776 11:40:56 INFO - PROCESS | 13113 | 11:43:58 INFO - PROCESS | 13113 | Cycle 1(1): loaded http://localhost:35143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35143/tests/dromaeo/cssquery-prototype.html) 11:43:58 INFO - PROCESS | 13113 | RSS: Main: 238043136 11:43:58 INFO - PROCESS | 13113 | 11:47:01 INFO - PROCESS | 13113 | Cycle 1(1): loaded http://localhost:35143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35143/tests/dromaeo/cssquery-yui.html) 11:47:02 INFO - PROCESS | 13113 | RSS: Main: 223395840 11:47:02 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | Cycle 1(1): loaded http://localhost:35143/tests/dromaeo/cssquery-yui.html (next: http://localhost:35143/tests/dromaeo/cssquery-dojo.html) 11:50:05 INFO - PROCESS | 13113 | RSS: Main: 258088960 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | __start_tp_report 11:50:05 INFO - PROCESS | 13113 | _x_x_mozilla_page_load 11:50:05 INFO - PROCESS | 13113 | _x_x_mozilla_page_load_details 11:50:05 INFO - PROCESS | 13113 | |i|pagename|runs| 11:50:05 INFO - PROCESS | 13113 | |0;dojo.html;3152.542881282213;3152.6059242594674;3168.017914446521;3195.185227766919;3214.5178223266507;5343.118385466403;5409.134538473845;5432.456754324566;5537.3632032316245;5561.638493497925;5500.257465242191;5521.751521181546;5534.778608855651;5550.8057217997375;5567.638103523268;4971.279164521142;5039.798408063673;5064.037832811754;5083.18669012958;5188.066148093341;5120.539151476366;5141.691498510083;5160.277561141444;5184.53339199472;5191.0656081905245;4866.853994380156;4906.877328066809;5010.799568017275;5056.761093532108;5066.82266120684;4950.257461380786;4960.479149689267;4972.627052971042;4980.77586508608;5027.698338099689;4986.10250154972;5021.372328458942;5027.5977921766535;5034.924476132861;5041.621878359138;5278.498542638443;5407.810726624549;5468.671879687232;5476.205950137248;5494.478024587658;5820.301563812327;5923.970380148115;5942.286925568917;5943.881122377571;5996.220491336142;5910.763569457259;5941.405859414067;5945.464908158243;5963.016102343108;5971.373005834368;5374.516293533601;5485.588580856412;5549.417311182348;5552.805651802168;5586.888262234814;6158.7228574714245;6159.96920015406;6169.537284703665;6172.814815555541;6177.660228687376;5588.804391846266;5899;5955.225820643289;5959.940400596025;5960.7019649017375;5905.704714764244;5939.584229104008;5954.553408494294;5983.102534619755;5997.670128142994;5909.852253693692;5960.910586341209;5962.493188079062;5966.731497082642;5967.8209653710455;5576.330840299109;5770.567207459458;5938.703064846741;5991.4907232884825;5993.400659933972;4419.027813880941;4454.710443821141;4458.219811533034;4497.437820272466;4501.099780044005;3946.1515774108702;3968.920621587552;3978.900527486836;3983.103801644607;4010.1779135277197;5439.456054394608;5484.369297530835;5572.721363931868;5593.328800543961;5654.321481422256;5901.616394934315;5951.672658003851;5980.073088671263;5986.281646202397;6032.698365081728;5552.167174923713;5579.191017302468;5582.63712858671;5585.469380408855;5678.4037676044245;4960;5097.46476619957;5125.410577783528;5126.53861152498;5135.512126347991;6237.875242495215;6243.875122497525;6244.875102497925;6249.125122482856;6256.499480041586;5998.310194327708;6028.33688294296;6029.427204415573;6029.849253768515;6075.1798507200965;6003.369646187088;6073.14975903365;6117.724702388314;6174.629522228681;6236.688165591611;5809.970950145223;5831.7375718093635;5848.619839710405;5851.180834683233;5886.23478947734;5910.202122713378;5941.257342832146;5943.940560594338;5948.732307046107;5956.404359564009;5668.376478587435;5769.423057694365;5787.131930210502;5818.4763371296785;5832.50423713989;5772.855678607901;5777.94222057774;5807.070868660994;5812.651240925558;5816;5617.297837770278;5674.148877668383;5752.223449834219;5758.481736643722;5759.8560035999435;5682.545396368363;5790;5793.188953546422;5800.274965629296;5924.585279030426;5703.4296570344295;5707.143928410605;5711.771529138954;5716.54267658578;5723.914141287801 11:50:05 INFO - PROCESS | 13113 | |1;ext.html;585.8593937455012;616.6146158650843;619.928708198557;635.6408629124544;637.5091179791564;31083;43584;44925;44941.55058449411;48499;44939.775301123445;45564.316535252;45635.54364456354;45644.315335269996;45666.543334566646;8815.955920220389;8995.32535059873;9001.909980900205;9028.277737780962;9034.68378606749;8773.64905403783;8945.55272236389;8946.060663630291;8947.239484643813;8952.283817294601;8938.553072346389;8972.955135224314;8989.505577193251;8991.190792828644;8994.055624159435;8885.911140888606;8937.285017198608;8952.507612081301;8952.59713312896;8960.865587016167;8858.778530536723;8974.641014359418;8978.371513994023;8981.506017169053;8982.595783189772;41802.37296440556;42109.36835947463;42352;42359.788201059106;42447.78776106131;3227.451333273326;3301.2407146356472;3359.1266270769775;3633.691136253395;4122.958770412318;30635.693643063507;32088.518672219703;32688.509672354932;32875.17812054694;33458.1635459113;4316.26623474007;4407.405000324947;4410.372800388507;4416.2713152329825;4438.622717069053;350757;352955;352962;356324;357905.6314155264;62275.688621556605;62531;62770.37229627737;62986.68506657529;63042.36957630457;58877.41122588805;66267.66866165734;66404.33595663981;66544;66577.6671116651;15414.46049388266;15967.121808300655;16001.919990400207;16431.342746290255;16480.34078636865;11976.16166868311;12090.818637720442;12121.27272363661;12145.210561313663;12171.695707607381;17435;19264.61470770577;19641.31255406054;19990.20039198416;20037.699434508493;7181.3895818854935;7188.5327453715345;7352.70589176427;7387.113546374362;7434.702611895572;1026.9473789365811;1035.321864178964;1089.1123734156795;1149.8965093141658;1170.8887655672697;33065.17337066593;33256.33487330288;33452.49821252683;33511;34019;1117.5306371324064;1127.7800828838297;1153.4405813180601;1157.346099453806;1181.3030312115893;17077.316907323817;17292.913535432242;17457.38899138524;17463;17566;549301;556424;556569;557328;557664;57679;58515.70742146347;58885.705571471866;58909.11636325459;59080.40919590835;1354.3837553913143;1366.5080570994435;1391.1305434103685;1394.198335956829;1406.2827957741422;30478.542821858133;32601.67398326081;32687.673123269415;33118.503222452164;33308.833455832566;51740;52073.479265206865;52131.21803172879;52173.7391313041;52194;484887;488083;489447;489691;489811;27800.582991255553;28856.71143288624;28885;28895.5665665011;28906.566401504417;47227.76386118047;48664.27003594878;49487;49725.75137124291;49938.25092623541;41025.589744103374;41099.178016438906;41340.586594134875;41895.7905210472;42510.787446062575;39413.2117357657;40554.594454055084;40738.79630601828;40764.79617601893;41669;41909.371359430246;42550.78724606357;42696.146077078905;43396.13207735891;43815.56184438115;36071.27857442784;36209;36913;37282.06794830151;37495.2500949974;27949.86025069943;28191.43617127605;28505.28736781597;28563.143105706862;28613.14160575186 11:50:05 INFO - PROCESS | 13113 | |2;jquery.html;378.95073640426773;391.13559034533677;404.807716334741;409.3123552431915;423.99152016959664;14571.12573245606;18569.53576160595;18668.346607868727;18954.810451895475;18985.14566844492;18009.459716208534;18516.537086572807;18645.347412840554;18769.155388007537;18770.249190032384;4025.6148306879595;5642.294713160844;5813.5349172066135;5814.738336774855;5835.941640583582;6174.969125154368;6489.740410383579;6501.902471462909;6502.902456463157;6504.1869766279215;6414.2302923648995;6462.0306953956815;6472.320406357336;6592.637404942726;6605.933940660604;6474.0612611171355;6503.057056726748;6569.343065693441;6585.802425927206;6586.901196482033;5597.7201139943245;5703.77184912603;5743.770249190027;5749.080147176432;5750.424957504258;22159;22431.887840560692;22761.43096422586;22821.31536053921;22835;2139.850210485267;2302.527981763751;2358.5872472317446;2404.7475015123337;2428.3807629054654;10094.192464602815;10846.29499082557;12291.323977181251;13825.51610693621;14148.797352225074;1884.9528761780928;1912.531429799694;1944.3097700316325;1959.9412017639352;2016.4757163137542;79624;80053.59973200154;82438.58780706058;82641.58679206626;82923.5853820733;10960.725981850517;11097.944510277397;11144.219904606762;11222.719432014102;11290.153238507144;15443.691126177413;15519.767203491956;15694.215289235493;15700.057996520245;15709.528714138594;7735.9613201933635;7963.641636126388;8030.437869349206;8138.308243799225;8186.386021048445;7571.583562904093;7591;7648.579328137006;7697.615119244016;7718.575478348633;4737.502562230985;4800.567948884617;4805.231163013901;4862.9756851216225;4874.317595536628;1977.6934575140876;2028.4928767808049;2033.298512013353;2050.8359331253464;2055.5580550181485;874.4359887872414;966.4587830814767;1017.3234798858676;1039.0907955538903;1071.5178169823455;18083.363305758732;18430.17064232086;18709.345172918882;18848.52878678044;18997.715034274497;976.8778902637171;979.5787811241235;1006.8439391894268;1045.628801775374;1091.3833683968533;10286.897131028743;10577.84133238002;10660.840087398696;10703.78592428147;10752.19358548112;386741;389631;392310;489348;510378;90458.54770726104;95693.5215323919;98322;99687.50156249173;101321.49339253256;1057.8836328003913;1071.276888100529;1083.3770581915273;1087.331291255872;1094.0645747885603;17105.914470427568;17144.082503840018;17531.737023944905;17535.912320438318;17628.29486820513;30240.395192096476;32349.514757279132;40823.79588102159;41385;41605.37591936063;56192.157117644085;57137.42862571487;57146.42853571411;57326;58194.7090264546;7515.173330933483;7948.284654381134;8671.523066231166;8699.43453675509;8712.39013269065;13007.804882926574;13062.281574513492;13358.866411335763;13390.93304533471;13544.86455135436;8287.673972164424;10978.670639880816;11694;11843.881561184622;12004.819927700917;11662.475188616363;11669;11807;11813.881861181622;11958.58144964922;11946.522139114339;12186.329751863732;12260.38698065111;12269.202501837352;12326.81509777336;7956.721514746956;8023.518588884685;8052.074011488754;8147.388945828968;8253.546054966795;10935.945320273666;11988.700282492659;12001.699957501132;12172.57395991136;12176 11:50:05 INFO - PROCESS | 13113 | |3;mootools.html;1364.8703373179544;1533.6932613477304;1552.860242578168;1703.3186725309874;1863.7670291213599;8164.061132969703;8551.315894728423;8562.957185214082;8566.229039386462;8770.56147192641;8399.748007559767;8645;8860.335474839381;8861.73414797557;8866.866996995033;2009.3971808457404;2168.728908886389;2226.9888650556722;2242.0023089725078;2262.2760716570706;2220.222921977311;2224.5106076663187;2226.599212141822;2228.933132006034;2229.4649284171765;2315.6758053872472;2365.4086478380405;2365.9589780496613;2368.4789346343778;2368.7394386617457;2019.5859848730975;2243.0691263125864;2309.2494939144844;2314.0859360552654;2322.814174866007;2189.386971647941;2198.2635817001324;2201.9889900550393;2204.867707937513;2239.7648246934;8845.469271843709;8860.272246911854;8897.777555561099;8905.575107982757;8911.287097032222;5254.395744489394;5404.081306177959;5407.621466497347;5410.648307860016;5415.810446634349;3300.174956260935;3425.4348032574594;3473.478978153272;3492.9650703492894;3497.265574229415;1115.3921112993437;1130.2653275371074;1143.1426430177366;1151.7005578549554;1169.099793159271;12241.387930603434;12420.130590858644;12471.625851224479;12478.563250286286;12497.812532812015;4599.195140850405;4750.477447480775;4793.856184314476;4825.396825396825;4843.176659967814;10665.84001239982;10672.679819605424;10674.46627668629;10687.198460115522;10708.89291107079;4545.6136228420955;5244.449332820075;5252.842414727565;5259.0796610593;5266.7629956652045;4791.520847915251;4982.576480999083;4995.500449954975;5010.098182327216;5035.194368900959;4085.7344272622186;4121.814518346681;4147.440095587057;4165.58344165581;4197.790110494463;1283.2044132637639;1291.289790615158;1312.3372696788251;1314.2246074815714;1329.9667508312175;950.3300173377752;980.6959842448864;982.9459379734184;993.2749093161888;995.9253056020827;5944.494717949023;6036.788712395045;6073.5748497604745;6193.6903154842075;6245.906311405332;459.3546067774782;464.35686574094444;473.81284392665395;477.362720767772;478.3136199553582;3976.483057202603;4091.8772436826944;4128.236276288896;4129.710920235555;4148.315527937856;10727.034566889017;11045.558177672803;11128.332300062022;11129.443527823576;11158.497867595977;10596.099331556905;10900.890991090146;10951.069159121405;11000.889991099986;11004;8056.516609003362;8328.750137495763;8383.371247156365;8399.496030238082;8407.873881891777;6033.42682445167;6296.275928268308;6301.8109456716375;6340.904886426615;6353.142325786144;9889.208863290776;10181.643642472478;10316.845247321146;10401.375917444977;10428;10391.532381043022;10580.36517808934;10595.364278143335;10717.732056698645;10729.141668666643;7304.707811687473;7483.064616922885;7670.578118203553;7694.846103077795;7826.882596761167;8564;8592.957035214784;8625.91374086251;8663.6101375437;8668.959724833061;7562.321066964589;7827.452078354689;7828.569428681477;7920.643571039202;7929.643166057426;7561.130469996021;7636.770896873103;7762.41781866351;7816.88274675869;7893.486923349964;6881.483888708467;6939.687714052779;6958.373746362851;6958.686859091455;6961.756338528127;5006.148954677787;5060.8987820242655;5154.819581314636;5187.870303242449;5257.763400647056;5120.564751995973;5196.272521846869;5211.60912931524;5279.102552565996;5306.257124002565 11:50:05 INFO - PROCESS | 13113 | |4;prototype.html;330.3575321032924;337.9459286514157;343.60485441742003;344.1602489924584;350.5320397269645;5182.637215394919;5187.792488300468;5216.087184742674;5220.347456567929;5258.237555554442;5183.948160518394;5195.778991936902;5217.3217481727415;5232.6075544334135;5240.375483600086;3950.3927407910783;4152.833886644546;4155.6883233757435;4186.204621121985;4208.936865947013;3785.9432108518395;4030.637242648161;4065.820911935535;4094.324436467994;4164.875053748392;4073.714839961204;4092.242935057009;4100.712950093494;4114.362273847559;4115.753054816721;4088;4113.958860411418;4122.773247471403;4122.958770412288;4127.29835927893;3539.2213712983103;3591.6947059499976;3653.3241350350004;3662.359087159736;3707.443883417509;4961.5286547777905;4971.1797553404;4992.500749925015;5002.624803139743;5040.445550989388;4658.813647454098;4686.109639168581;4686.695364801277;4702.482726900038;4718;5305.575553955674;5328.573714102862;5400.432954539795;5406.621311565565;5423.322084739408;3992.4210989406374;4011.5988401159943;4012.257732319501;4015.6988225883174;4016.176683779818;5369.570434365241;5453.509184173444;5689.317281926195;5693.800716974927;5698.173764804122;4083.4079058536345;4092.4475195848777;4096.73371230869;4104.774237416911;4115.218108559364;4143.295639741251;4161.729487583298;4165.8958526037095;4169.915821886331;4179.9582004179565;4530.682852200381;4654.488006319302;4698.600618947359;4699.412573428322;4725.645576581702;5420.457954204548;5440.646357986798;5466.644668096561;5473.2063850742215;5486.341639003345;1412.6892083741561;1430.9268048963277;1434.7130573885265;1447.6380904773807;1449.4999225267266;904.1410659873147;933.8645896344992;939.6006697153682;948.9383190092622;960.3181740963994;4733.479317275097;4734.201003618603;4738.246848665946;4774.95225047745;4781.593564546983;4946.95762106302;4973.801047958041;4981.900361992813;4995.325631039763;5025.869179434598;4565.954340456619;4682.993156471307;4762.261849413347;4781.354517140211;4850.611951043908;2686.8312284156063;2692.7307269272915;2693.8383696978244;2697.8381297122237;2703.5539136042726;5078.492150784966;5108.66793658411;5173.999080533282;5207.635465517453;5210.6613070150315;4901.730404827768;5026.698398096126;5039.974800125976;5055.646104772631;5085.694858308513;5100.260462232955;5140.306058682105;5151.171334176388;5203.349581302413;5243.7750783268775;4893.828715994923;5004.698778317591;5063.924041139312;5072.59419246452;5087.211482220262;4748.406449193851;4888.92666609994;4934.975325123495;4960.702357858396;4991.975040124777;5153.149730294459;5538.806141785019;5744.4829965303325;5752.856178595569;5776.624519406225;3955.4264631627675;4070.776107314126;4139.2615101656775;4176.519700234512;4178.22702799983;5437.8368648940595;5453.863653408696;5560.749766260609;5654.293213348332;5666.660000399989;5344.812931547533;5423.83728488146;5462.371827239759;5474;5504.504594586507;5336.199570064521;5356.276902618097;5406.702631355313;5431.755570999236;5449.809256675997;5115.64190506661;5342.465753424626;5364.436734142859;5367.785288588413;5377.8924421510565;5430.891382172414;5450.400455949763;5452.36429071285;5471.644343117685;5486;5318.175682769177;5341.172118321666;5343.7862485500145;5347.572194224531;5370.785168593369 11:50:05 INFO - PROCESS | 13113 | |5;yui.html;721.9820053724249;758.203885919784;795.6896810244006;796.538007955386;832.1844592299542;13700.177989320635;13719.58841234762;13758.793618095737;14278.714425711492;15046.924765376185;13532.864671353283;13651.658708532292;13697.726045479085;13702.383392747326;13714.108582942103;682.6996121706458;791.9841603167933;806.657170702452;823.5347028928666;830.7383174300106;824.7690646618927;825.6078362777663;825.6160885188416;825.8513467575834;826.2811354121923;862.6075135813221;865.247234905633;866.2117473099481;866.3935245328264;866.536403024382;705.2101646156286;822.3051521464353;857.391252210931;861.5218553702724;861.6165806216236;628.5757113948113;629.3360504667573;631.0376675569793;631.2992578238152;631.5074242091176;13902.930485347508;14074.2962851857;14127.081739686888;14152.080114792609;14164;13643.181409115385;14076.859231407658;14230.359633816399;14335.713285734331;14730.852691473056;11275.60535381266;11438.942805286004;11886.524539018428;12178.451969661386;12218.511259549607;4086.6117718816963;4261.87214383569;4301.354796780477;4417.072414792898;4418.734875907456;70625;70656.29343706548;70871;71167.2883271171;72646;10789.730256743644;10976.341419514854;11049;11064.723381915517;11122.165837562216;20576.38270851877;20614.896925515277;20617.278395256093;20665.483362915747;20696.275630352866;8094.514329140153;8156.225158609923;8198.918010819934;8432.957835210786;8435.620397082022;4360.65980404316;4375.693701440869;4376;4420.9336859947125;4508.413906192174;3466.791992480459;3576.1774791798034;3576.3741345264475;3581.212133330663;3585.2829434113282;514.951079647433;574.4313130001269;597.8475488750428;599.4604855629968;621.5183232994466;698.6192525073847;716.559316020654;719.8200449887528;741.7700512841036;753.2655660730744;8967.282617390592;8980.416272942368;9000.819983600291;9043.457392556336;9276.814463710823;682.5631595778706;689.7447944260656;712.6116266634593;713.0979311171373;729.9416046716357;4236.152769446123;4270.850520231777;4389.240114044874;4510.548945105464;4510.824096671834;110345;120471;121854;123780;126541;57018.7149064252;57871.4212857866;102110;106294;106565;73114.63442682753;81222;81292;81625.59187204145;82280;9258.49078300673;9540.427574345562;9575.133857172537;9579.377340472847;9848.901510985084;48187.38594605349;49435.011299774524;49469.26857559968;49739.75130124326;50893.74553127211;63820.68089659522;68045;70643;71162.22094447681;71498.64250678713;12377.690557736129;12489.750204996031;12718.745625087631;12759.93620031894;13246.07277490605;13538.390772415461;13999.534701837783;14029.3686784097;14231.857681423053;14438.133711977314;13111.93444032812;13280.800787987995;13396.26320552379;13459.3943272551;13690.247036412695;13276.468941242241;13500.392482338515;13592.79610805819;13732.65668358299;13775.242361670204;12068;12551.225949850561;12984.610461686165;13037.674058148243;13265;9029.426613415146;9597.23222142241;9803.460809655537;10982.423350697845;11002.724931876766;10483.947580262355;11149.442527873736;11236.490781945315;11396.259243149168;11434.485448154686 11:50:05 INFO - PROCESS | 13113 | __end_tp_report 11:50:05 INFO - PROCESS | 13113 | __start_cc_report 11:50:05 INFO - PROCESS | 13113 | _x_x_mozilla_cycle_collect,1092 11:50:05 INFO - PROCESS | 13113 | __end_cc_report 11:50:05 INFO - PROCESS | 13113 | __startTimestamp1464893405337__endTimestamp 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | ------- Summary: start ------- 11:50:05 INFO - PROCESS | 13113 | Number of tests: 6 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | [#0] dojo.html Cycles:165 Average:5503.61 Median:5707.14 stddev:648.02 (11.4%) stddev-sans-first:623.21 11:50:05 INFO - PROCESS | 13113 | Values: 3152.5 3152.6 3168.0 3195.2 3214.5 5343.1 5409.1 5432.5 5537.4 5561.6 5500.3 5521.8 5534.8 5550.8 5567.6 4971.3 5039.8 5064.0 5083.2 5188.1 5120.5 5141.7 5160.3 5184.5 5191.1 4866.9 4906.9 5010.8 5056.8 5066.8 4950.3 4960.5 4972.6 4980.8 5027.7 4986.1 5021.4 5027.6 5034.9 5041.6 5278.5 5407.8 5468.7 5476.2 5494.5 5820.3 5924.0 5942.3 5943.9 5996.2 5910.8 5941.4 5945.5 5963.0 5971.4 5374.5 5485.6 5549.4 5552.8 5586.9 6158.7 6160.0 6169.5 6172.8 6177.7 5588.8 5899.0 5955.2 5959.9 5960.7 5905.7 5939.6 5954.6 5983.1 5997.7 5909.9 5960.9 5962.5 5966.7 5967.8 5576.3 5770.6 5938.7 5991.5 5993.4 4419.0 4454.7 4458.2 4497.4 4501.1 3946.2 3968.9 3978.9 3983.1 4010.2 5439.5 5484.4 5572.7 5593.3 5654.3 5901.6 5951.7 5980.1 5986.3 6032.7 5552.2 5579.2 5582.6 5585.5 5678.4 4960.0 5097.5 5125.4 5126.5 5135.5 6237.9 6243.9 6244.9 6249.1 6256.5 5998.3 6028.3 6029.4 6029.8 6075.2 6003.4 6073.1 6117.7 6174.6 6236.7 5810.0 5831.7 5848.6 5851.2 5886.2 5910.2 5941.3 5943.9 5948.7 5956.4 5668.4 5769.4 5787.1 5818.5 5832.5 5772.9 5777.9 5807.1 5812.7 5816.0 5617.3 5674.1 5752.2 5758.5 5759.9 5682.5 5790.0 5793.2 5800.3 5924.6 5703.4 5707.1 5711.8 5716.5 5723.9 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | [#1] ext.html Cycles:180 Average:62829.68 Median:42479.29 stddev:125716.22 (295.9%) stddev-sans-first:125982.03 11:50:05 INFO - PROCESS | 13113 | Values: 585.9 616.6 619.9 635.6 637.5 31083.0 43584.0 44925.0 44941.6 48499.0 44939.8 45564.3 45635.5 45644.3 45666.5 8816.0 8995.3 9001.9 9028.3 9034.7 8773.6 8945.6 8946.1 8947.2 8952.3 8938.6 8973.0 8989.5 8991.2 8994.1 8885.9 8937.3 8952.5 8952.6 8960.9 8858.8 8974.6 8978.4 8981.5 8982.6 41802.4 42109.4 42352.0 42359.8 42447.8 3227.5 3301.2 3359.1 3633.7 4123.0 30635.7 32088.5 32688.5 32875.2 33458.2 4316.3 4407.4 4410.4 4416.3 4438.6 350757.0 352955.0 352962.0 356324.0 357905.6 62275.7 62531.0 62770.4 62986.7 63042.4 58877.4 66267.7 66404.3 66544.0 66577.7 15414.5 15967.1 16001.9 16431.3 16480.3 11976.2 12090.8 12121.3 12145.2 12171.7 17435.0 19264.6 19641.3 19990.2 20037.7 7181.4 7188.5 7352.7 7387.1 7434.7 1026.9 1035.3 1089.1 1149.9 1170.9 33065.2 33256.3 33452.5 33511.0 34019.0 1117.5 1127.8 1153.4 1157.3 1181.3 17077.3 17292.9 17457.4 17463.0 17566.0 549301.0 556424.0 556569.0 557328.0 557664.0 57679.0 58515.7 58885.7 58909.1 59080.4 1354.4 1366.5 1391.1 1394.2 1406.3 30478.5 32601.7 32687.7 33118.5 33308.8 51740.0 52073.5 52131.2 52173.7 52194.0 484887.0 488083.0 489447.0 489691.0 489811.0 27800.6 28856.7 28885.0 28895.6 28906.6 47227.8 48664.3 49487.0 49725.8 49938.3 41025.6 41099.2 41340.6 41895.8 42510.8 39413.2 40554.6 40738.8 40764.8 41669.0 41909.4 42550.8 42696.1 43396.1 43815.6 36071.3 36209.0 36913.0 37282.1 37495.3 27949.9 28191.4 28505.3 28563.1 28613.1 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | [#2] jquery.html Cycles:180 Average:27467.81 Median:22828.16 stddev:72531.85 (317.7%) stddev-sans-first:72706.80 11:50:05 INFO - PROCESS | 13113 | Values: 379.0 391.1 404.8 409.3 424.0 14571.1 18569.5 18668.3 18954.8 18985.1 18009.5 18516.5 18645.3 18769.2 18770.2 4025.6 5642.3 5813.5 5814.7 5835.9 6175.0 6489.7 6501.9 6502.9 6504.2 6414.2 6462.0 6472.3 6592.6 6605.9 6474.1 6503.1 6569.3 6585.8 6586.9 5597.7 5703.8 5743.8 5749.1 5750.4 22159.0 22431.9 22761.4 22821.3 22835.0 2139.9 2302.5 2358.6 2404.7 2428.4 10094.2 10846.3 12291.3 13825.5 14148.8 1885.0 1912.5 1944.3 1959.9 2016.5 79624.0 80053.6 82438.6 82641.6 82923.6 10960.7 11097.9 11144.2 11222.7 11290.2 15443.7 15519.8 15694.2 15700.1 15709.5 7736.0 7963.6 8030.4 8138.3 8186.4 7571.6 7591.0 7648.6 7697.6 7718.6 4737.5 4800.6 4805.2 4863.0 4874.3 1977.7 2028.5 2033.3 2050.8 2055.6 874.4 966.5 1017.3 1039.1 1071.5 18083.4 18430.2 18709.3 18848.5 18997.7 976.9 979.6 1006.8 1045.6 1091.4 10286.9 10577.8 10660.8 10703.8 10752.2 386741.0 389631.0 392310.0 489348.0 510378.0 90458.5 95693.5 98322.0 99687.5 101321.5 1057.9 1071.3 1083.4 1087.3 1094.1 17105.9 17144.1 17531.7 17535.9 17628.3 30240.4 32349.5 40823.8 41385.0 41605.4 56192.2 57137.4 57146.4 57326.0 58194.7 7515.2 7948.3 8671.5 8699.4 8712.4 13007.8 13062.3 13358.9 13390.9 13544.9 8287.7 10978.7 11694.0 11843.9 12004.8 11662.5 11669.0 11807.0 11813.9 11958.6 11946.5 12186.3 12260.4 12269.2 12326.8 7956.7 8023.5 8052.1 8147.4 8253.5 10935.9 11988.7 12001.7 12172.6 12176.0 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | [#3] mootools.html Cycles:180 Average:5843.48 Median:477.84 stddev:3365.59 (704.3%) stddev-sans-first:3358.20 11:50:05 INFO - PROCESS | 13113 | Values: 1364.9 1533.7 1552.9 1703.3 1863.8 8164.1 8551.3 8563.0 8566.2 8770.6 8399.7 8645.0 8860.3 8861.7 8866.9 2009.4 2168.7 2227.0 2242.0 2262.3 2220.2 2224.5 2226.6 2228.9 2229.5 2315.7 2365.4 2366.0 2368.5 2368.7 2019.6 2243.1 2309.2 2314.1 2322.8 2189.4 2198.3 2202.0 2204.9 2239.8 8845.5 8860.3 8897.8 8905.6 8911.3 5254.4 5404.1 5407.6 5410.6 5415.8 3300.2 3425.4 3473.5 3493.0 3497.3 1115.4 1130.3 1143.1 1151.7 1169.1 12241.4 12420.1 12471.6 12478.6 12497.8 4599.2 4750.5 4793.9 4825.4 4843.2 10665.8 10672.7 10674.5 10687.2 10708.9 4545.6 5244.4 5252.8 5259.1 5266.8 4791.5 4982.6 4995.5 5010.1 5035.2 4085.7 4121.8 4147.4 4165.6 4197.8 1283.2 1291.3 1312.3 1314.2 1330.0 950.3 980.7 982.9 993.3 995.9 5944.5 6036.8 6073.6 6193.7 6245.9 459.4 464.4 473.8 477.4 478.3 3976.5 4091.9 4128.2 4129.7 4148.3 10727.0 11045.6 11128.3 11129.4 11158.5 10596.1 10900.9 10951.1 11000.9 11004.0 8056.5 8328.8 8383.4 8399.5 8407.9 6033.4 6296.3 6301.8 6340.9 6353.1 9889.2 10181.6 10316.8 10401.4 10428.0 10391.5 10580.4 10595.4 10717.7 10729.1 7304.7 7483.1 7670.6 7694.8 7826.9 8564.0 8593.0 8625.9 8663.6 8669.0 7562.3 7827.5 7828.6 7920.6 7929.6 7561.1 7636.8 7762.4 7816.9 7893.5 6881.5 6939.7 6958.4 6958.7 6961.8 5006.1 5060.9 5154.8 5187.9 5257.8 5120.6 5196.3 5211.6 5279.1 5306.3 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | [#4] prototype.html Cycles:180 Average:4467.13 Median:4986.94 stddev:1264.85 (25.4%) stddev-sans-first:1229.70 11:50:05 INFO - PROCESS | 13113 | Values: 330.4 337.9 343.6 344.2 350.5 5182.6 5187.8 5216.1 5220.3 5258.2 5183.9 5195.8 5217.3 5232.6 5240.4 3950.4 4152.8 4155.7 4186.2 4208.9 3785.9 4030.6 4065.8 4094.3 4164.9 4073.7 4092.2 4100.7 4114.4 4115.8 4088.0 4114.0 4122.8 4123.0 4127.3 3539.2 3591.7 3653.3 3662.4 3707.4 4961.5 4971.2 4992.5 5002.6 5040.4 4658.8 4686.1 4686.7 4702.5 4718.0 5305.6 5328.6 5400.4 5406.6 5423.3 3992.4 4011.6 4012.3 4015.7 4016.2 5369.6 5453.5 5689.3 5693.8 5698.2 4083.4 4092.4 4096.7 4104.8 4115.2 4143.3 4161.7 4165.9 4169.9 4180.0 4530.7 4654.5 4698.6 4699.4 4725.6 5420.5 5440.6 5466.6 5473.2 5486.3 1412.7 1430.9 1434.7 1447.6 1449.5 904.1 933.9 939.6 948.9 960.3 4733.5 4734.2 4738.2 4775.0 4781.6 4947.0 4973.8 4981.9 4995.3 5025.9 4566.0 4683.0 4762.3 4781.4 4850.6 2686.8 2692.7 2693.8 2697.8 2703.6 5078.5 5108.7 5174.0 5207.6 5210.7 4901.7 5026.7 5040.0 5055.6 5085.7 5100.3 5140.3 5151.2 5203.3 5243.8 4893.8 5004.7 5063.9 5072.6 5087.2 4748.4 4888.9 4935.0 4960.7 4992.0 5153.1 5538.8 5744.5 5752.9 5776.6 3955.4 4070.8 4139.3 4176.5 4178.2 5437.8 5453.9 5560.7 5654.3 5666.7 5344.8 5423.8 5462.4 5474.0 5504.5 5336.2 5356.3 5406.7 5431.8 5449.8 5115.6 5342.5 5364.4 5367.8 5377.9 5430.9 5450.4 5452.4 5471.6 5486.0 5318.2 5341.2 5343.8 5347.6 5370.8 11:50:05 INFO - PROCESS | 13113 | 11:50:05 INFO - PROCESS | 13113 | [#5] yui.html Cycles:180 Average:19825.36 Median:4419.83 stddev:28927.68 (654.5%) stddev-sans-first:28973.27 11:50:05 INFO - PROCESS | 13113 | Values: 722.0 758.2 795.7 796.5 832.2 13700.2 13719.6 13758.8 14278.7 15046.9 13532.9 13651.7 13697.7 13702.4 13714.1 682.7 792.0 806.7 823.5 830.7 824.8 825.6 825.6 825.9 826.3 862.6 865.2 866.2 866.4 866.5 705.2 822.3 857.4 861.5 861.6 628.6 629.3 631.0 631.3 631.5 13902.9 14074.3 14127.1 14152.1 14164.0 13643.2 14076.9 14230.4 14335.7 14730.9 11275.6 11438.9 11886.5 12178.5 12218.5 4086.6 4261.9 4301.4 4417.1 4418.7 70625.0 70656.3 70871.0 71167.3 72646.0 10789.7 10976.3 11049.0 11064.7 11122.2 20576.4 20614.9 20617.3 20665.5 20696.3 8094.5 8156.2 8198.9 8433.0 8435.6 4360.7 4375.7 4376.0 4420.9 4508.4 3466.8 3576.2 3576.4 3581.2 3585.3 515.0 574.4 597.8 599.5 621.5 698.6 716.6 719.8 741.8 753.3 8967.3 8980.4 9000.8 9043.5 9276.8 682.6 689.7 712.6 713.1 729.9 4236.2 4270.9 4389.2 4510.5 4510.8 110345.0 120471.0 121854.0 123780.0 126541.0 57018.7 57871.4 102110.0 106294.0 106565.0 73114.6 81222.0 81292.0 81625.6 82280.0 9258.5 9540.4 9575.1 9579.4 9848.9 48187.4 49435.0 49469.3 49739.8 50893.7 63820.7 68045.0 70643.0 71162.2 71498.6 12377.7 12489.8 12718.7 12759.9 13246.1 13538.4 13999.5 14029.4 14231.9 14438.1 13111.9 13280.8 13396.3 13459.4 13690.2 13276.5 13500.4 13592.8 13732.7 13775.2 12068.0 12551.2 12984.6 13037.7 13265.0 9029.4 9597.2 9803.5 10982.4 11002.7 10483.9 11149.4 11236.5 11396.3 11434.5 11:50:05 INFO - PROCESS | 13113 | -------- Summary: end -------- 11:50:05 INFO - PROCESS | 13113 | 11:50:06 INFO - TEST-INFO | 13113: exit 0 11:50:06 INFO - TEST-OK | dromaeo_css | took 1112886ms 11:50:06 INFO - TEST-START | kraken 11:50:06 INFO - operating with platform_type : linux_ 11:50:06 INFO - Initialising browser for kraken test... 11:50:06 INFO - TEST-INFO | started process 13291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8eEWfh/profile http://localhost:35143/getInfo.html) 11:50:09 INFO - PROCESS | 13291 | __metrics Screen width/height:1600/1200 11:50:09 INFO - PROCESS | 13291 | colorDepth:24 11:50:09 INFO - PROCESS | 13291 | Browser inner width/height: 1024/697 11:50:09 INFO - PROCESS | 13291 | __metrics 11:50:10 ERROR - PROCESS | 13291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:50:11 INFO - TEST-INFO | 13291: exit 0 11:50:11 INFO - Browser initialized. 11:50:11 INFO - Running cycle 1/1 for kraken test... 11:50:11 INFO - TEST-INFO | started process 13373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8eEWfh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:23 INFO - PROCESS | 13373 | RSS: Main: 155623424 11:50:23 INFO - PROCESS | 13373 | 11:50:26 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35143/tests/kraken/driver.html?testName=audio-beat-detection) 11:50:26 INFO - PROCESS | 13373 | RSS: Main: 214523904 11:50:26 INFO - PROCESS | 13373 | 11:50:29 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35143/tests/kraken/driver.html?testName=audio-dft) 11:50:30 INFO - PROCESS | 13373 | RSS: Main: 201117696 11:50:30 INFO - PROCESS | 13373 | 11:50:33 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35143/tests/kraken/driver.html?testName=audio-fft) 11:50:33 INFO - PROCESS | 13373 | RSS: Main: 268455936 11:50:33 INFO - PROCESS | 13373 | 11:50:36 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35143/tests/kraken/driver.html?testName=audio-oscillator) 11:50:36 INFO - PROCESS | 13373 | RSS: Main: 179404800 11:50:36 INFO - PROCESS | 13373 | 11:50:38 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:50:39 INFO - PROCESS | 13373 | RSS: Main: 183345152 11:50:39 INFO - PROCESS | 13373 | 11:50:42 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35143/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:42 INFO - PROCESS | 13373 | RSS: Main: 217657344 11:50:42 INFO - PROCESS | 13373 | 11:50:46 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35143/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:46 INFO - PROCESS | 13373 | RSS: Main: 219553792 11:50:46 INFO - PROCESS | 13373 | 11:50:49 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35143/tests/kraken/driver.html?testName=json-parse-financial) 11:50:50 INFO - PROCESS | 13373 | RSS: Main: 220049408 11:50:50 INFO - PROCESS | 13373 | 11:50:51 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:52 INFO - PROCESS | 13373 | RSS: Main: 206872576 11:50:52 INFO - PROCESS | 13373 | 11:50:54 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:54 INFO - PROCESS | 13373 | RSS: Main: 210817024 11:50:54 INFO - PROCESS | 13373 | 11:50:56 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:50:57 INFO - PROCESS | 13373 | RSS: Main: 218677248 11:50:57 INFO - PROCESS | 13373 | 11:51:00 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:00 INFO - PROCESS | 13373 | RSS: Main: 222195712 11:51:00 INFO - PROCESS | 13373 | 11:51:03 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:04 INFO - PROCESS | 13373 | RSS: Main: 220319744 11:51:04 INFO - PROCESS | 13373 | 11:51:05 INFO - PROCESS | 13373 | Cycle 1(1): loaded http://localhost:35143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35143/tests/kraken/driver.html?testName=ai-astar) 11:51:06 INFO - PROCESS | 13373 | RSS: Main: 262692864 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | __start_tp_report 11:51:06 INFO - PROCESS | 13373 | _x_x_mozilla_page_load 11:51:06 INFO - PROCESS | 13373 | _x_x_mozilla_page_load_details 11:51:06 INFO - PROCESS | 13373 | |i|pagename|runs| 11:51:06 INFO - PROCESS | 13373 | |0;ai-astar;113;105;113;112;111;112;113;110;110;111 11:51:06 INFO - PROCESS | 13373 | |1;audio-beat-detection;159;126;129;179;130;127;155;124;196;124 11:51:06 INFO - PROCESS | 13373 | |2;audio-dft;160;160;161;162;162;161;161;161;162;161 11:51:06 INFO - PROCESS | 13373 | |3;audio-fft;74;73;76;119;84;75;74;74;98;75 11:51:06 INFO - PROCESS | 13373 | |4;audio-oscillator;83;84;116;84;83;83;115;83;84;129 11:51:06 INFO - PROCESS | 13373 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;116;116;116 11:51:06 INFO - PROCESS | 13373 | |6;imaging-darkroom;146;145;146;146;146;146;146;148;146;145 11:51:06 INFO - PROCESS | 13373 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;96 11:51:06 INFO - PROCESS | 13373 | |8;json-parse-financial;52;53;52;51;52;54;53;52;52;53 11:51:06 INFO - PROCESS | 13373 | |9;json-stringify-tinderbox;62;63;61;63;63;63;63;62;62;62 11:51:06 INFO - PROCESS | 13373 | |10;stanford-crypto-aes;79;79;79;84;85;80;81;81;114;80 11:51:06 INFO - PROCESS | 13373 | |11;stanford-crypto-ccm;122;125;127;127;120;121;120;130;129;131 11:51:06 INFO - PROCESS | 13373 | |12;stanford-crypto-pbkdf2;164;158;159;157;160;161;158;157;158;158 11:51:06 INFO - PROCESS | 13373 | |13;stanford-crypto-sha256-iterative;62;63;64;62;64;65;63;66;62;61 11:51:06 INFO - PROCESS | 13373 | __end_tp_report 11:51:06 INFO - PROCESS | 13373 | __start_cc_report 11:51:06 INFO - PROCESS | 13373 | _x_x_mozilla_cycle_collect,1654 11:51:06 INFO - PROCESS | 13373 | __end_cc_report 11:51:06 INFO - PROCESS | 13373 | __startTimestamp1464893466017__endTimestamp 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | ------- Summary: start ------- 11:51:06 INFO - PROCESS | 13373 | Number of tests: 14 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.40 (2.1%) stddev-sans-first:2.44 11:51:06 INFO - PROCESS | 13373 | Values: 113.0 105.0 113.0 112.0 111.0 112.0 113.0 110.0 110.0 111.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:142.50 stddev:26.04 (18.3%) stddev-sans-first:27.11 11:51:06 INFO - PROCESS | 13373 | Values: 159.0 126.0 129.0 179.0 130.0 127.0 155.0 124.0 196.0 124.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 11:51:06 INFO - PROCESS | 13373 | Values: 160.0 160.0 161.0 162.0 162.0 161.0 161.0 161.0 162.0 161.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.04 (20.1%) stddev-sans-first:15.66 11:51:06 INFO - PROCESS | 13373 | Values: 74.0 73.0 76.0 119.0 84.0 75.0 74.0 74.0 98.0 75.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.00 stddev:18.05 (21.7%) stddev-sans-first:18.67 11:51:06 INFO - PROCESS | 13373 | Values: 83.0 84.0 116.0 84.0 83.0 83.0 115.0 83.0 84.0 129.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:51:06 INFO - PROCESS | 13373 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 116.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 11:51:06 INFO - PROCESS | 13373 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 148.0 146.0 145.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:51:06 INFO - PROCESS | 13373 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:0.84 (1.6%) stddev-sans-first:0.88 11:51:06 INFO - PROCESS | 13373 | Values: 52.0 53.0 52.0 51.0 52.0 54.0 53.0 52.0 52.0 53.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 11:51:06 INFO - PROCESS | 13373 | Values: 62.0 63.0 61.0 63.0 63.0 63.0 63.0 62.0 62.0 62.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:80.50 stddev:10.67 (13.3%) stddev-sans-first:11.16 11:51:06 INFO - PROCESS | 13373 | Values: 79.0 79.0 79.0 84.0 85.0 80.0 81.0 81.0 114.0 80.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:127.00 stddev:4.21 (3.3%) stddev-sans-first:4.30 11:51:06 INFO - PROCESS | 13373 | Values: 122.0 125.0 127.0 127.0 120.0 121.0 120.0 130.0 129.0 131.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:158.50 stddev:2.16 (1.4%) stddev-sans-first:1.33 11:51:06 INFO - PROCESS | 13373 | Values: 164.0 158.0 159.0 157.0 160.0 161.0 158.0 157.0 158.0 158.0 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - PROCESS | 13373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.55 (2.4%) stddev-sans-first:1.58 11:51:06 INFO - PROCESS | 13373 | Values: 62.0 63.0 64.0 62.0 64.0 65.0 63.0 66.0 62.0 61.0 11:51:06 INFO - PROCESS | 13373 | -------- Summary: end -------- 11:51:06 INFO - PROCESS | 13373 | 11:51:06 INFO - TEST-INFO | 13373: exit 0 11:51:06 INFO - TEST-OK | kraken | took 60936ms 11:51:06 INFO - SUITE-END | took 1173s 11:51:07 INFO - Completed test suite (00:19:34) 11:51:07 INFO - javascript benchmark 11:51:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.542881282213, 3152.6059242594674, 3168.017914446521, 3195.185227766919, 3214.5178223266507, 5343.118385466403, 5409.134538473845, 5432.456754324566, 5537.3632032316245, 5561.638493497925, 5500.257465242191, 5521.751521181546, 5534.778608855651, 5550.8057217997375, 5567.638103523268, 4971.279164521142, 5039.798408063673, 5064.037832811754, 5083.18669012958, 5188.066148093341, 5120.539151476366, 5141.691498510083, 5160.277561141444, 5184.53339199472, 5191.0656081905245, 4866.853994380156, 4906.877328066809, 5010.799568017275, 5056.761093532108, 5066.82266120684, 4950.257461380786, 4960.479149689267, 4972.627052971042, 4980.77586508608, 5027.698338099689, 4986.10250154972, 5021.372328458942, 5027.5977921766535, 5034.924476132861, 5041.621878359138, 5278.498542638443, 5407.810726624549, 5468.671879687232, 5476.205950137248, 5494.478024587658, 5820.301563812327, 5923.970380148115, 5942.286925568917, 5943.881122377571, 5996.220491336142, 5910.763569457259, 5941.405859414067, 5945.464908158243, 5963.016102343108, 5971.373005834368, 5374.516293533601, 5485.588580856412, 5549.417311182348, 5552.805651802168, 5586.888262234814, 6158.7228574714245, 6159.96920015406, 6169.537284703665, 6172.814815555541, 6177.660228687376, 5588.804391846266, 5899.0, 5955.225820643289, 5959.940400596025, 5960.7019649017375, 5905.704714764244, 5939.584229104008, 5954.553408494294, 5983.102534619755, 5997.670128142994, 5909.852253693692, 5960.910586341209, 5962.493188079062, 5966.731497082642, 5967.8209653710455, 5576.330840299109, 5770.567207459458, 5938.703064846741, 5991.4907232884825, 5993.400659933972, 4419.027813880941, 4454.710443821141, 4458.219811533034, 4497.437820272466, 4501.099780044005, 3946.1515774108702, 3968.920621587552, 3978.900527486836, 3983.103801644607, 4010.1779135277197, 5439.456054394608, 5484.369297530835, 5572.721363931868, 5593.328800543961, 5654.321481422256, 5901.616394934315, 5951.672658003851, 5980.073088671263, 5986.281646202397, 6032.698365081728, 5552.167174923713, 5579.191017302468, 5582.63712858671, 5585.469380408855, 5678.4037676044245, 4960.0, 5097.46476619957, 5125.410577783528, 5126.53861152498, 5135.512126347991, 6237.875242495215, 6243.875122497525, 6244.875102497925, 6249.125122482856, 6256.499480041586, 5998.310194327708, 6028.33688294296, 6029.427204415573, 6029.849253768515, 6075.1798507200965, 6003.369646187088, 6073.14975903365, 6117.724702388314, 6174.629522228681, 6236.688165591611, 5809.970950145223, 5831.7375718093635, 5848.619839710405, 5851.180834683233, 5886.23478947734, 5910.202122713378, 5941.257342832146, 5943.940560594338, 5948.732307046107, 5956.404359564009, 5668.376478587435, 5769.423057694365, 5787.131930210502, 5818.4763371296785, 5832.50423713989, 5772.855678607901, 5777.94222057774, 5807.070868660994, 5812.651240925558, 5816.0, 5617.297837770278, 5674.148877668383, 5752.223449834219, 5758.481736643722, 5759.8560035999435, 5682.545396368363, 5790.0, 5793.188953546422, 5800.274965629296, 5924.585279030426, 5703.4296570344295, 5707.143928410605, 5711.771529138954, 5716.54267658578, 5723.914141287801], "value": 5458.4007610581075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8593937455012, 616.6146158650843, 619.928708198557, 635.6408629124544, 637.5091179791564, 31083.0, 43584.0, 44925.0, 44941.55058449411, 48499.0, 44939.775301123445, 45564.316535252, 45635.54364456354, 45644.315335269996, 45666.543334566646, 8815.955920220389, 8995.32535059873, 9001.909980900205, 9028.277737780962, 9034.68378606749, 8773.64905403783, 8945.55272236389, 8946.060663630291, 8947.239484643813, 8952.283817294601, 8938.553072346389, 8972.955135224314, 8989.505577193251, 8991.190792828644, 8994.055624159435, 8885.911140888606, 8937.285017198608, 8952.507612081301, 8952.59713312896, 8960.865587016167, 8858.778530536723, 8974.641014359418, 8978.371513994023, 8981.506017169053, 8982.595783189772, 41802.37296440556, 42109.36835947463, 42352.0, 42359.788201059106, 42447.78776106131, 3227.451333273326, 3301.2407146356472, 3359.1266270769775, 3633.691136253395, 4122.958770412318, 30635.693643063507, 32088.518672219703, 32688.509672354932, 32875.17812054694, 33458.1635459113, 4316.26623474007, 4407.405000324947, 4410.372800388507, 4416.2713152329825, 4438.622717069053, 350757.0, 352955.0, 352962.0, 356324.0, 357905.6314155264, 62275.688621556605, 62531.0, 62770.37229627737, 62986.68506657529, 63042.36957630457, 58877.41122588805, 66267.66866165734, 66404.33595663981, 66544.0, 66577.6671116651, 15414.46049388266, 15967.121808300655, 16001.919990400207, 16431.342746290255, 16480.34078636865, 11976.16166868311, 12090.818637720442, 12121.27272363661, 12145.210561313663, 12171.695707607381, 17435.0, 19264.61470770577, 19641.31255406054, 19990.20039198416, 20037.699434508493, 7181.3895818854935, 7188.5327453715345, 7352.70589176427, 7387.113546374362, 7434.702611895572, 1026.9473789365811, 1035.321864178964, 1089.1123734156795, 1149.8965093141658, 1170.8887655672697, 33065.17337066593, 33256.33487330288, 33452.49821252683, 33511.0, 34019.0, 1117.5306371324064, 1127.7800828838297, 1153.4405813180601, 1157.346099453806, 1181.3030312115893, 17077.316907323817, 17292.913535432242, 17457.38899138524, 17463.0, 17566.0, 549301.0, 556424.0, 556569.0, 557328.0, 557664.0, 57679.0, 58515.70742146347, 58885.705571471866, 58909.11636325459, 59080.40919590835, 1354.3837553913143, 1366.5080570994435, 1391.1305434103685, 1394.198335956829, 1406.2827957741422, 30478.542821858133, 32601.67398326081, 32687.673123269415, 33118.503222452164, 33308.833455832566, 51740.0, 52073.479265206865, 52131.21803172879, 52173.7391313041, 52194.0, 484887.0, 488083.0, 489447.0, 489691.0, 489811.0, 27800.582991255553, 28856.71143288624, 28885.0, 28895.5665665011, 28906.566401504417, 47227.76386118047, 48664.27003594878, 49487.0, 49725.75137124291, 49938.25092623541, 41025.589744103374, 41099.178016438906, 41340.586594134875, 41895.7905210472, 42510.787446062575, 39413.2117357657, 40554.594454055084, 40738.79630601828, 40764.79617601893, 41669.0, 41909.371359430246, 42550.78724606357, 42696.146077078905, 43396.13207735891, 43815.56184438115, 36071.27857442784, 36209.0, 36913.0, 37282.06794830151, 37495.2500949974, 27949.86025069943, 28191.43617127605, 28505.28736781597, 28563.143105706862, 28613.14160575186], "value": 20498.83186669049, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.95073640426773, 391.13559034533677, 404.807716334741, 409.3123552431915, 423.99152016959664, 14571.12573245606, 18569.53576160595, 18668.346607868727, 18954.810451895475, 18985.14566844492, 18009.459716208534, 18516.537086572807, 18645.347412840554, 18769.155388007537, 18770.249190032384, 4025.6148306879595, 5642.294713160844, 5813.5349172066135, 5814.738336774855, 5835.941640583582, 6174.969125154368, 6489.740410383579, 6501.902471462909, 6502.902456463157, 6504.1869766279215, 6414.2302923648995, 6462.0306953956815, 6472.320406357336, 6592.637404942726, 6605.933940660604, 6474.0612611171355, 6503.057056726748, 6569.343065693441, 6585.802425927206, 6586.901196482033, 5597.7201139943245, 5703.77184912603, 5743.770249190027, 5749.080147176432, 5750.424957504258, 22159.0, 22431.887840560692, 22761.43096422586, 22821.31536053921, 22835.0, 2139.850210485267, 2302.527981763751, 2358.5872472317446, 2404.7475015123337, 2428.3807629054654, 10094.192464602815, 10846.29499082557, 12291.323977181251, 13825.51610693621, 14148.797352225074, 1884.9528761780928, 1912.531429799694, 1944.3097700316325, 1959.9412017639352, 2016.4757163137542, 79624.0, 80053.59973200154, 82438.58780706058, 82641.58679206626, 82923.5853820733, 10960.725981850517, 11097.944510277397, 11144.219904606762, 11222.719432014102, 11290.153238507144, 15443.691126177413, 15519.767203491956, 15694.215289235493, 15700.057996520245, 15709.528714138594, 7735.9613201933635, 7963.641636126388, 8030.437869349206, 8138.308243799225, 8186.386021048445, 7571.583562904093, 7591.0, 7648.579328137006, 7697.615119244016, 7718.575478348633, 4737.502562230985, 4800.567948884617, 4805.231163013901, 4862.9756851216225, 4874.317595536628, 1977.6934575140876, 2028.4928767808049, 2033.298512013353, 2050.8359331253464, 2055.5580550181485, 874.4359887872414, 966.4587830814767, 1017.3234798858676, 1039.0907955538903, 1071.5178169823455, 18083.363305758732, 18430.17064232086, 18709.345172918882, 18848.52878678044, 18997.715034274497, 976.8778902637171, 979.5787811241235, 1006.8439391894268, 1045.628801775374, 1091.3833683968533, 10286.897131028743, 10577.84133238002, 10660.840087398696, 10703.78592428147, 10752.19358548112, 386741.0, 389631.0, 392310.0, 489348.0, 510378.0, 90458.54770726104, 95693.5215323919, 98322.0, 99687.50156249173, 101321.49339253256, 1057.8836328003913, 1071.276888100529, 1083.3770581915273, 1087.331291255872, 1094.0645747885603, 17105.914470427568, 17144.082503840018, 17531.737023944905, 17535.912320438318, 17628.29486820513, 30240.395192096476, 32349.514757279132, 40823.79588102159, 41385.0, 41605.37591936063, 56192.157117644085, 57137.42862571487, 57146.42853571411, 57326.0, 58194.7090264546, 7515.173330933483, 7948.284654381134, 8671.523066231166, 8699.43453675509, 8712.39013269065, 13007.804882926574, 13062.281574513492, 13358.866411335763, 13390.93304533471, 13544.86455135436, 8287.673972164424, 10978.670639880816, 11694.0, 11843.881561184622, 12004.819927700917, 11662.475188616363, 11669.0, 11807.0, 11813.881861181622, 11958.58144964922, 11946.522139114339, 12186.329751863732, 12260.38698065111, 12269.202501837352, 12326.81509777336, 7956.721514746956, 8023.518588884685, 8052.074011488754, 8147.388945828968, 8253.546054966795, 10935.945320273666, 11988.700282492659, 12001.699957501132, 12172.57395991136, 12176.0], "value": 9280.590611335134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.8703373179544, 1533.6932613477304, 1552.860242578168, 1703.3186725309874, 1863.7670291213599, 8164.061132969703, 8551.315894728423, 8562.957185214082, 8566.229039386462, 8770.56147192641, 8399.748007559767, 8645.0, 8860.335474839381, 8861.73414797557, 8866.866996995033, 2009.3971808457404, 2168.728908886389, 2226.9888650556722, 2242.0023089725078, 2262.2760716570706, 2220.222921977311, 2224.5106076663187, 2226.599212141822, 2228.933132006034, 2229.4649284171765, 2315.6758053872472, 2365.4086478380405, 2365.9589780496613, 2368.4789346343778, 2368.7394386617457, 2019.5859848730975, 2243.0691263125864, 2309.2494939144844, 2314.0859360552654, 2322.814174866007, 2189.386971647941, 2198.2635817001324, 2201.9889900550393, 2204.867707937513, 2239.7648246934, 8845.469271843709, 8860.272246911854, 8897.777555561099, 8905.575107982757, 8911.287097032222, 5254.395744489394, 5404.081306177959, 5407.621466497347, 5410.648307860016, 5415.810446634349, 3300.174956260935, 3425.4348032574594, 3473.478978153272, 3492.9650703492894, 3497.265574229415, 1115.3921112993437, 1130.2653275371074, 1143.1426430177366, 1151.7005578549554, 1169.099793159271, 12241.387930603434, 12420.130590858644, 12471.625851224479, 12478.563250286286, 12497.812532812015, 4599.195140850405, 4750.477447480775, 4793.856184314476, 4825.396825396825, 4843.176659967814, 10665.84001239982, 10672.679819605424, 10674.46627668629, 10687.198460115522, 10708.89291107079, 4545.6136228420955, 5244.449332820075, 5252.842414727565, 5259.0796610593, 5266.7629956652045, 4791.520847915251, 4982.576480999083, 4995.500449954975, 5010.098182327216, 5035.194368900959, 4085.7344272622186, 4121.814518346681, 4147.440095587057, 4165.58344165581, 4197.790110494463, 1283.2044132637639, 1291.289790615158, 1312.3372696788251, 1314.2246074815714, 1329.9667508312175, 950.3300173377752, 980.6959842448864, 982.9459379734184, 993.2749093161888, 995.9253056020827, 5944.494717949023, 6036.788712395045, 6073.5748497604745, 6193.6903154842075, 6245.906311405332, 459.3546067774782, 464.35686574094444, 473.81284392665395, 477.362720767772, 478.3136199553582, 3976.483057202603, 4091.8772436826944, 4128.236276288896, 4129.710920235555, 4148.315527937856, 10727.034566889017, 11045.558177672803, 11128.332300062022, 11129.443527823576, 11158.497867595977, 10596.099331556905, 10900.890991090146, 10951.069159121405, 11000.889991099986, 11004.0, 8056.516609003362, 8328.750137495763, 8383.371247156365, 8399.496030238082, 8407.873881891777, 6033.42682445167, 6296.275928268308, 6301.8109456716375, 6340.904886426615, 6353.142325786144, 9889.208863290776, 10181.643642472478, 10316.845247321146, 10401.375917444977, 10428.0, 10391.532381043022, 10580.36517808934, 10595.364278143335, 10717.732056698645, 10729.141668666643, 7304.707811687473, 7483.064616922885, 7670.578118203553, 7694.846103077795, 7826.882596761167, 8564.0, 8592.957035214784, 8625.91374086251, 8663.6101375437, 8668.959724833061, 7562.321066964589, 7827.452078354689, 7828.569428681477, 7920.643571039202, 7929.643166057426, 7561.130469996021, 7636.770896873103, 7762.41781866351, 7816.88274675869, 7893.486923349964, 6881.483888708467, 6939.687714052779, 6958.373746362851, 6958.686859091455, 6961.756338528127, 5006.148954677787, 5060.8987820242655, 5154.819581314636, 5187.870303242449, 5257.763400647056, 5120.564751995973, 5196.272521846869, 5211.60912931524, 5279.102552565996, 5306.257124002565], "value": 4583.896037797779, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.3575321032924, 337.9459286514157, 343.60485441742003, 344.1602489924584, 350.5320397269645, 5182.637215394919, 5187.792488300468, 5216.087184742674, 5220.347456567929, 5258.237555554442, 5183.948160518394, 5195.778991936902, 5217.3217481727415, 5232.6075544334135, 5240.375483600086, 3950.3927407910783, 4152.833886644546, 4155.6883233757435, 4186.204621121985, 4208.936865947013, 3785.9432108518395, 4030.637242648161, 4065.820911935535, 4094.324436467994, 4164.875053748392, 4073.714839961204, 4092.242935057009, 4100.712950093494, 4114.362273847559, 4115.753054816721, 4088.0, 4113.958860411418, 4122.773247471403, 4122.958770412288, 4127.29835927893, 3539.2213712983103, 3591.6947059499976, 3653.3241350350004, 3662.359087159736, 3707.443883417509, 4961.5286547777905, 4971.1797553404, 4992.500749925015, 5002.624803139743, 5040.445550989388, 4658.813647454098, 4686.109639168581, 4686.695364801277, 4702.482726900038, 4718.0, 5305.575553955674, 5328.573714102862, 5400.432954539795, 5406.621311565565, 5423.322084739408, 3992.4210989406374, 4011.5988401159943, 4012.257732319501, 4015.6988225883174, 4016.176683779818, 5369.570434365241, 5453.509184173444, 5689.317281926195, 5693.800716974927, 5698.173764804122, 4083.4079058536345, 4092.4475195848777, 4096.73371230869, 4104.774237416911, 4115.218108559364, 4143.295639741251, 4161.729487583298, 4165.8958526037095, 4169.915821886331, 4179.9582004179565, 4530.682852200381, 4654.488006319302, 4698.600618947359, 4699.412573428322, 4725.645576581702, 5420.457954204548, 5440.646357986798, 5466.644668096561, 5473.2063850742215, 5486.341639003345, 1412.6892083741561, 1430.9268048963277, 1434.7130573885265, 1447.6380904773807, 1449.4999225267266, 904.1410659873147, 933.8645896344992, 939.6006697153682, 948.9383190092622, 960.3181740963994, 4733.479317275097, 4734.201003618603, 4738.246848665946, 4774.95225047745, 4781.593564546983, 4946.95762106302, 4973.801047958041, 4981.900361992813, 4995.325631039763, 5025.869179434598, 4565.954340456619, 4682.993156471307, 4762.261849413347, 4781.354517140211, 4850.611951043908, 2686.8312284156063, 2692.7307269272915, 2693.8383696978244, 2697.8381297122237, 2703.5539136042726, 5078.492150784966, 5108.66793658411, 5173.999080533282, 5207.635465517453, 5210.6613070150315, 4901.730404827768, 5026.698398096126, 5039.974800125976, 5055.646104772631, 5085.694858308513, 5100.260462232955, 5140.306058682105, 5151.171334176388, 5203.349581302413, 5243.7750783268775, 4893.828715994923, 5004.698778317591, 5063.924041139312, 5072.59419246452, 5087.211482220262, 4748.406449193851, 4888.92666609994, 4934.975325123495, 4960.702357858396, 4991.975040124777, 5153.149730294459, 5538.806141785019, 5744.4829965303325, 5752.856178595569, 5776.624519406225, 3955.4264631627675, 4070.776107314126, 4139.2615101656775, 4176.519700234512, 4178.22702799983, 5437.8368648940595, 5453.863653408696, 5560.749766260609, 5654.293213348332, 5666.660000399989, 5344.812931547533, 5423.83728488146, 5462.371827239759, 5474.0, 5504.504594586507, 5336.199570064521, 5356.276902618097, 5406.702631355313, 5431.755570999236, 5449.809256675997, 5115.64190506661, 5342.465753424626, 5364.436734142859, 5367.785288588413, 5377.8924421510565, 5430.891382172414, 5450.400455949763, 5452.36429071285, 5471.644343117685, 5486.0, 5318.175682769177, 5341.172118321666, 5343.7862485500145, 5347.572194224531, 5370.785168593369], "value": 4072.456240154175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.9820053724249, 758.203885919784, 795.6896810244006, 796.538007955386, 832.1844592299542, 13700.177989320635, 13719.58841234762, 13758.793618095737, 14278.714425711492, 15046.924765376185, 13532.864671353283, 13651.658708532292, 13697.726045479085, 13702.383392747326, 13714.108582942103, 682.6996121706458, 791.9841603167933, 806.657170702452, 823.5347028928666, 830.7383174300106, 824.7690646618927, 825.6078362777663, 825.6160885188416, 825.8513467575834, 826.2811354121923, 862.6075135813221, 865.247234905633, 866.2117473099481, 866.3935245328264, 866.536403024382, 705.2101646156286, 822.3051521464353, 857.391252210931, 861.5218553702724, 861.6165806216236, 628.5757113948113, 629.3360504667573, 631.0376675569793, 631.2992578238152, 631.5074242091176, 13902.930485347508, 14074.2962851857, 14127.081739686888, 14152.080114792609, 14164.0, 13643.181409115385, 14076.859231407658, 14230.359633816399, 14335.713285734331, 14730.852691473056, 11275.60535381266, 11438.942805286004, 11886.524539018428, 12178.451969661386, 12218.511259549607, 4086.6117718816963, 4261.87214383569, 4301.354796780477, 4417.072414792898, 4418.734875907456, 70625.0, 70656.29343706548, 70871.0, 71167.2883271171, 72646.0, 10789.730256743644, 10976.341419514854, 11049.0, 11064.723381915517, 11122.165837562216, 20576.38270851877, 20614.896925515277, 20617.278395256093, 20665.483362915747, 20696.275630352866, 8094.514329140153, 8156.225158609923, 8198.918010819934, 8432.957835210786, 8435.620397082022, 4360.65980404316, 4375.693701440869, 4376.0, 4420.9336859947125, 4508.413906192174, 3466.791992480459, 3576.1774791798034, 3576.3741345264475, 3581.212133330663, 3585.2829434113282, 514.951079647433, 574.4313130001269, 597.8475488750428, 599.4604855629968, 621.5183232994466, 698.6192525073847, 716.559316020654, 719.8200449887528, 741.7700512841036, 753.2655660730744, 8967.282617390592, 8980.416272942368, 9000.819983600291, 9043.457392556336, 9276.814463710823, 682.5631595778706, 689.7447944260656, 712.6116266634593, 713.0979311171373, 729.9416046716357, 4236.152769446123, 4270.850520231777, 4389.240114044874, 4510.548945105464, 4510.824096671834, 110345.0, 120471.0, 121854.0, 123780.0, 126541.0, 57018.7149064252, 57871.4212857866, 102110.0, 106294.0, 106565.0, 73114.63442682753, 81222.0, 81292.0, 81625.59187204145, 82280.0, 9258.49078300673, 9540.427574345562, 9575.133857172537, 9579.377340472847, 9848.901510985084, 48187.38594605349, 49435.011299774524, 49469.26857559968, 49739.75130124326, 50893.74553127211, 63820.68089659522, 68045.0, 70643.0, 71162.22094447681, 71498.64250678713, 12377.690557736129, 12489.750204996031, 12718.745625087631, 12759.93620031894, 13246.07277490605, 13538.390772415461, 13999.534701837783, 14029.3686784097, 14231.857681423053, 14438.133711977314, 13111.93444032812, 13280.800787987995, 13396.26320552379, 13459.3943272551, 13690.247036412695, 13276.468941242241, 13500.392482338515, 13592.79610805819, 13732.65668358299, 13775.242361670204, 12068.0, 12551.225949850561, 12984.610461686165, 13037.674058148243, 13265.0, 9029.426613415146, 9597.23222142241, 9803.460809655537, 10982.423350697845, 11002.724931876766, 10483.947580262355, 11149.442527873736, 11236.490781945315, 11396.259243149168, 11434.485448154686], "value": 7331.5998915496575, "unit": "score"}], "name": "dromaeo_css", "value": 7224.113989457791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 113.0, 112.0, 111.0, 112.0, 113.0, 110.0, 110.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 129.0, 179.0, 130.0, 127.0, 155.0, 124.0, 196.0, 124.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 119.0, 84.0, 75.0, 74.0, 74.0, 98.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 116.0, 84.0, 83.0, 83.0, 115.0, 83.0, 84.0, 129.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 51.0, 52.0, 54.0, 53.0, 52.0, 52.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 84.0, 85.0, 80.0, 81.0, 81.0, 114.0, 80.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 127.0, 127.0, 120.0, 121.0, 120.0, 130.0, 129.0, 131.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 159.0, 157.0, 160.0, 161.0, 158.0, 157.0, 158.0, 158.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 62.0, 64.0, 65.0, 63.0, 66.0, 62.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1497.7000000000003, "alertThreshold": 2.0}]} 11:51:07 INFO - Return code: 0 11:51:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:51:07 ERROR - # TBPL SUCCESS # 11:51:07 INFO - Running post-action listener: _resource_record_post_action 11:51:07 INFO - ##### 11:51:07 INFO - ##### Finished run-tests step (success) 11:51:07 INFO - ##### 11:51:07 INFO - Running post-run listener: _resource_record_post_run 11:51:07 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541405184; Read time: 16; Write time: 431728 11:51:07 INFO - TinderboxPrint: CPU usage
13.2% 11:51:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:51:07 INFO - TinderboxPrint: I/O write bytes / time
541,405,184 / 431,728 11:51:07 INFO - TinderboxPrint: CPU idle
8,255.4 (86.8%) 11:51:07 INFO - TinderboxPrint: CPU user
1,213.9 (12.8%) 11:51:07 INFO - TinderboxPrint: Swap in / out
0 / 0 11:51:07 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247742464; Read time: 0; Write time: 238392 11:51:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293662720; Read time: 16; Write time: 193336 11:51:07 INFO - Running post-run listener: _upload_blobber_files 11:51:07 INFO - Blob upload gear active. 11:51:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:07 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:51:07 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:51:07 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:51:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:12 INFO - (blobuploader) - INFO - Done attempting. 11:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:13 INFO - (blobuploader) - INFO - Done attempting. 11:51:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:51:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:14 INFO - (blobuploader) - INFO - Done attempting. 11:51:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:51:14 INFO - Return code: 0 11:51:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:51:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:51:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da48dc3595a8f3c910a5254bbb59674537e48c33390aadde3b1e66a11227b25db1c0744cebb385e8e3be34186917d567ea32a3b9ab203359bf6ffa09190a545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3863e631e7c9bead97fcc6c8fd0bf90584e86aef5c5d450f6b029a33445d0d419e87942ca2cc0ef4b7fb2afc0e2e298ece7b4f07115103a23977d3dfafd8738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c46378d130331bb92311e95101afee0674c52d9a01df791888a398e86c8e6423bb4e126fbcce619880762cbaa39567ff802e893591c63149ca9b681aa19a9ca"} 11:51:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:51:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:51:14 INFO - Contents: 11:51:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da48dc3595a8f3c910a5254bbb59674537e48c33390aadde3b1e66a11227b25db1c0744cebb385e8e3be34186917d567ea32a3b9ab203359bf6ffa09190a545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3863e631e7c9bead97fcc6c8fd0bf90584e86aef5c5d450f6b029a33445d0d419e87942ca2cc0ef4b7fb2afc0e2e298ece7b4f07115103a23977d3dfafd8738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c46378d130331bb92311e95101afee0674c52d9a01df791888a398e86c8e6423bb4e126fbcce619880762cbaa39567ff802e893591c63149ca9b681aa19a9ca"} 11:51:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:51:14 INFO - Copying logs to upload dir... 11:51:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:51:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.553924 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-02 11:51:14.815249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 11:51:14.818879) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da48dc3595a8f3c910a5254bbb59674537e48c33390aadde3b1e66a11227b25db1c0744cebb385e8e3be34186917d567ea32a3b9ab203359bf6ffa09190a545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3863e631e7c9bead97fcc6c8fd0bf90584e86aef5c5d450f6b029a33445d0d419e87942ca2cc0ef4b7fb2afc0e2e298ece7b4f07115103a23977d3dfafd8738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c46378d130331bb92311e95101afee0674c52d9a01df791888a398e86c8e6423bb4e126fbcce619880762cbaa39567ff802e893591c63149ca9b681aa19a9ca"} 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.011372 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da48dc3595a8f3c910a5254bbb59674537e48c33390aadde3b1e66a11227b25db1c0744cebb385e8e3be34186917d567ea32a3b9ab203359bf6ffa09190a545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3863e631e7c9bead97fcc6c8fd0bf90584e86aef5c5d450f6b029a33445d0d419e87942ca2cc0ef4b7fb2afc0e2e298ece7b4f07115103a23977d3dfafd8738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c46378d130331bb92311e95101afee0674c52d9a01df791888a398e86c8e6423bb4e126fbcce619880762cbaa39567ff802e893591c63149ca9b681aa19a9ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 11:51:14.843809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:51:14.844129) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464890680.654182-1329236029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:51:14.928281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 11:51:14.928775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 11:51:14.929229) ========= ========= Total master_lag: 0.15 =========